builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-059 starttime: 1506336570.56 results: success (0) revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.560847) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.561249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.561513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.586010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.586303) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 03:49:30-- 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% 46.5M=0s 2017-09-25 03:49:30 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.737135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.737417) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.786436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:30.786726) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --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=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 03:49:30,810 truncating revision to first 12 chars 2017-09-25 03:49:30,810 Setting DEBUG logging. 2017-09-25 03:49:30,811 attempt 1/10 2017-09-25 03:49:30,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13ce77b78e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 03:49:31,076 unpacking tar archive at: mozilla-central-13ce77b78e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:31.326489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:31.326788) ========= script_repo_revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:31.327145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:31.327414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:49:31.340722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-25 03:49:31.340999) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:31 INFO - MultiFileLogger online at 20170925 03:49:31 in /builds/slave/test 03:49:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:49:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:31 INFO - {'append_to_log': False, 03:49:31 INFO - 'base_work_dir': '/builds/slave/test', 03:49:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:31 INFO - 'branch': 'Firefox-Non-PGO', 03:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:31 INFO - 'code_coverage': False, 03:49:31 INFO - 'config_files': ('talos/linux_config.py',), 03:49:31 INFO - 'default_actions': ('clobber', 03:49:31 INFO - 'read-buildbot-config', 03:49:31 INFO - 'download-and-extract', 03:49:31 INFO - 'populate-webroot', 03:49:31 INFO - 'create-virtualenv', 03:49:31 INFO - 'install', 03:49:31 INFO - 'setup-mitmproxy', 03:49:31 INFO - 'run-tests'), 03:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:31 INFO - 'disable_ccov_upload': False, 03:49:31 INFO - 'disable_stylo': False, 03:49:31 INFO - 'download_minidump_stackwalk': True, 03:49:31 INFO - 'download_symbols': 'ondemand', 03:49:31 INFO - 'enable_stylo': False, 03:49:31 INFO - 'enable_webrender': False, 03:49:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:31 INFO - 'gecko_profile': False, 03:49:31 INFO - 'gecko_profile_interval': 0, 03:49:31 INFO - 'installer_path': 'installer.exe', 03:49:31 INFO - 'log_level': 'info', 03:49:31 INFO - 'log_name': 'talos', 03:49:31 INFO - 'log_to_console': True, 03:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:31 INFO - 'opt_config_files': (), 03:49:31 INFO - 'pip_index': False, 03:49:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:49:31 INFO - 'system_bits': '32', 03:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:31 INFO - 'title': 'talos-linux64-ix-059', 03:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:31 INFO - 'use_talos_json': True, 03:49:31 INFO - 'verify': 'False', 03:49:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:31 INFO - 'work_dir': 'build'} 03:49:31 INFO - [mozharness: 2017-09-25 10:49:31.510820Z] Running clobber step. 03:49:31 INFO - Running pre-action listener: _resource_record_pre_action 03:49:31 INFO - Running main action method: clobber 03:49:31 INFO - rmtree: /builds/slave/test/build 03:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:32 INFO - Running post-action listener: _resource_record_post_action 03:49:32 INFO - [mozharness: 2017-09-25 10:49:32.506665Z] Finished clobber step (success) 03:49:32 INFO - [mozharness: 2017-09-25 10:49:32.506763Z] Running read-buildbot-config step. 03:49:32 INFO - Running pre-action listener: _resource_record_pre_action 03:49:32 INFO - Running main action method: read_buildbot_config 03:49:32 INFO - Using buildbot properties: 03:49:32 INFO - { 03:49:32 INFO - "project": "", 03:49:32 INFO - "product": "firefox", 03:49:32 INFO - "who": "archaeopteryx@coole-files.de", 03:49:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:49:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:49:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:49:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:49:32 INFO - "stage_platform": "linux64", 03:49:32 INFO - "basedir": "/builds/slave/test", 03:49:32 INFO - "buildnumber": 39, 03:49:32 INFO - "platform": "ubuntu64_hw", 03:49:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:49:32 INFO - "slavebuilddir": "test", 03:49:32 INFO - "taskId": "A0i0TcHWRSapiousNNlYQA", 03:49:32 INFO - "branch": "mozilla-central", 03:49:32 INFO - "script_repo_revision": "production", 03:49:32 INFO - "revision": "13ce77b78e364cc952d51b959f22202502be2941", 03:49:32 INFO - "slavename": "talos-linux64-ix-059", 03:49:32 INFO - "repo_path": "mozilla-central" 03:49:32 INFO - } 03:49:32 INFO - Finding installer, test and symbols from parent task. 03:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0i0TcHWRSapiousNNlYQA'}, attempt #1 03:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0i0TcHWRSapiousNNlYQA'}, attempt #1 03:49:33 INFO - Task dependencies: JwN-TpclSCu1HPYGslnjhA 03:49:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA'}, attempt #1 03:49:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:49:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip 03:49:33 INFO - Running post-action listener: _resource_record_post_action 03:49:33 INFO - [mozharness: 2017-09-25 10:49:33.807347Z] Finished read-buildbot-config step (success) 03:49:33 INFO - [mozharness: 2017-09-25 10:49:33.807568Z] Running download-and-extract step. 03:49:33 INFO - Running pre-action listener: _resource_record_pre_action 03:49:33 INFO - Running main action method: download_and_extract 03:49:33 INFO - mkdir: /builds/slave/test/build/tests 03:49: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')]} 03:49:33 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:49:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:49:34 INFO - Downloaded 989 bytes. 03:49:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:49:34 INFO - Using the following test package requirements: 03:49:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:49:34 INFO - u'common': [u'target.common.tests.zip'], 03:49:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:49:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:49:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:49:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:49:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:49:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:49:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:49:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:49:34 INFO - u'target.web-platform.tests.tar.gz'], 03:49:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:49:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:49:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip 03:49:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:49:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip into memory 03:49:35 INFO - Content-Length response header: 54943883 03:49:35 INFO - Bytes received: 54943883 03:49:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip 03:49:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:49:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip into memory 03:49:47 INFO - Content-Length response header: 14513823 03:49:47 INFO - Bytes received: 14513823 03:49:47 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')]} 03:49:47 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:47 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:49:48 INFO - Downloaded 61752580 bytes. 03:49:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:48 INFO - mkdir: /builds/slave/test/properties 03:49:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:48 INFO - Contents: 03:49:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:49:48 INFO - Running post-action listener: _resource_record_post_action 03:49:48 INFO - Running post-action listener: find_tests_for_verification 03:49:48 INFO - Running post-action listener: set_extra_try_arguments 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.478072Z] Finished download-and-extract step (success) 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.478170Z] Running populate-webroot step. 03:49:48 INFO - Running pre-action listener: _resource_record_pre_action 03:49:48 INFO - Running main action method: populate_webroot 03:49:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:49:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tresize', 03:49:48 INFO - 'tcanvasmark']}, 03:49:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:49:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['dromaeo_css', 03:49:48 INFO - 'kraken']}, 03:49:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['damp', 'tps']}, 03:49:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['damp', 'tps']}, 03:49:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['dromaeo_dom']}, 03:49:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:49:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['basic_compositor_video', 03:49:48 INFO - 'glvideo']}, 03:49:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:49:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['ts_paint_webext', 03:49:48 INFO - 'tp5o_webext']}, 03:49:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:49:48 INFO - 'ts_paint', 03:49:48 INFO - 'tpaint', 03:49:48 INFO - 'sessionrestore', 03:49:48 INFO - 'sessionrestore_many_windows', 03:49:48 INFO - 'sessionrestore_no_auto_restore', 03:49:48 INFO - 'tabpaint']}, 03:49:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['a11yr', 03:49:48 INFO - 'ts_paint', 03:49:48 INFO - 'tpaint', 03:49:48 INFO - 'sessionrestore', 03:49:48 INFO - 'sessionrestore_many_windows', 03:49:48 INFO - 'sessionrestore_no_auto_restore', 03:49:48 INFO - 'tabpaint']}, 03:49:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:49:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:49:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['perf_reftest_singletons']}, 03:49:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['perf_reftest']}, 03:49:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:49:48 INFO - 'tsvgr_opacity', 03:49:48 INFO - 'tart', 03:49:48 INFO - 'tscrollx', 03:49:48 INFO - 'tsvg_static']}, 03:49:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tsvgx', 03:49:48 INFO - 'tsvgr_opacity', 03:49:48 INFO - 'tart', 03:49:48 INFO - 'tscrollx', 03:49:48 INFO - 'tsvg_static']}, 03:49:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:49:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo'], 03:49:48 INFO - 'tests': ['tp5o']}, 03:49:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--disable-stylo', 03:49:48 INFO - '--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:49:48 INFO - 'talos_options': ['--stylo-threads=1', 03:49:48 INFO - '--mitmproxy', 03:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:49:48 INFO - '--firstNonBlankPaint'], 03:49:48 INFO - 'tests': ['tp6_google', 03:49:48 INFO - 'tp6_youtube', 03:49:48 INFO - 'tp6_amazon', 03:49:48 INFO - 'tp6_facebook']}, 03:49:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--xperf_path', 03:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:48 INFO - 'tests': ['tp5n']}, 03:49:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:49:48 INFO - 'talos_options': ['--disable-stylo', 03:49:48 INFO - '--xperf_path', 03:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:48 INFO - 'tests': ['tp5n']}}} 03:49:48 INFO - Running post-action listener: _resource_record_post_action 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.493728Z] Finished populate-webroot step (success) 03:49:48 INFO - [mozharness: 2017-09-25 10:49:48.493819Z] Running create-virtualenv step. 03:49:48 INFO - Running pre-action listener: _resource_record_pre_action 03:49:48 INFO - Running main action method: create_virtualenv 03:49:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:49:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:49:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:49:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:49 INFO - Installing pip...............done. 03:49:49 INFO - Return code: 0 03:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:49:49 INFO - Reading from file tmpfile_stdout 03:49:49 INFO - Output received: 03:49:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:49:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:49 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49:49 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 03:49:49 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 03:49:49 INFO - Using env: {'DISPLAY': ':0', 03:49:49 INFO - 'HOME': '/home/cltbld', 03:49:49 INFO - 'LANG': 'en_US.UTF-8', 03:49:49 INFO - 'LANGUAGE': 'en_US:en', 03:49:49 INFO - 'LOGNAME': 'cltbld', 03:49:49 INFO - 'MAIL': '/var/mail/cltbld', 03:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:49 INFO - 'MOZ_NO_REMOTE': '1', 03:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:49 INFO - 'NO_EM_RESTART': '1', 03:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:49 INFO - 'PWD': '/builds/slave/test', 03:49:49 INFO - 'SHELL': '/bin/bash', 03:49:49 INFO - 'SHLVL': '1', 03:49:49 INFO - 'TERM': 'linux', 03:49:49 INFO - 'TMOUT': '86400', 03:49:49 INFO - 'USER': 'cltbld', 03:49:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:49 INFO - '_': '/tools/buildbot/bin/python'} 03:49:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:49:50 INFO - Downloading/unpacking pip>=1.5 03:49:50 INFO - Running setup.py egg_info for package pip 03:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:49:50 INFO - Installing collected packages: pip 03:49:50 INFO - Found existing installation: pip 1.1 03:49:50 INFO - Uninstalling pip: 03:49:50 INFO - Successfully uninstalled pip 03:49:50 INFO - Running setup.py install for pip 03:49:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:49:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:49:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:49:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:49:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:49:50 INFO - Successfully installed pip 03:49:50 INFO - Cleaning up... 03:49:50 INFO - Return code: 0 03:49:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:49:50 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')]} 03:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:50 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')]} 03:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:50 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49:50 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 03:49:50 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 03:49:50 INFO - Using env: {'DISPLAY': ':0', 03:49:50 INFO - 'HOME': '/home/cltbld', 03:49:50 INFO - 'LANG': 'en_US.UTF-8', 03:49:50 INFO - 'LANGUAGE': 'en_US:en', 03:49:50 INFO - 'LOGNAME': 'cltbld', 03:49:50 INFO - 'MAIL': '/var/mail/cltbld', 03:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:50 INFO - 'MOZ_NO_REMOTE': '1', 03:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:50 INFO - 'NO_EM_RESTART': '1', 03:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:50 INFO - 'PWD': '/builds/slave/test', 03:49:50 INFO - 'SHELL': '/bin/bash', 03:49:50 INFO - 'SHLVL': '1', 03:49:50 INFO - 'TERM': 'linux', 03:49:50 INFO - 'TMOUT': '86400', 03:49:50 INFO - 'USER': 'cltbld', 03:49:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:50 INFO - '_': '/tools/buildbot/bin/python'} 03:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:50 INFO - Downloading/unpacking psutil>=3.1.1 03:49:50 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 03:49:50 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 03:49:50 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 03:49:50 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 03:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:52 INFO - Installing collected packages: psutil 03:49:52 INFO - Running setup.py install for psutil 03:49:52 INFO - building 'psutil._psutil_linux' extension 03:49:52 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 03:49:52 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 03:49:52 INFO - building 'psutil._psutil_posix' extension 03:49:52 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 03:49:52 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 03:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:52 INFO - Successfully installed psutil 03:49:52 INFO - Cleaning up... 03:49:52 INFO - Return code: 0 03:49:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:49: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 mozsystemmonitor==0.3 03:49:52 INFO - Using env: {'DISPLAY': ':0', 03:49:52 INFO - 'HOME': '/home/cltbld', 03:49:52 INFO - 'LANG': 'en_US.UTF-8', 03:49:52 INFO - 'LANGUAGE': 'en_US:en', 03:49:52 INFO - 'LOGNAME': 'cltbld', 03:49:52 INFO - 'MAIL': '/var/mail/cltbld', 03:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:52 INFO - 'MOZ_NO_REMOTE': '1', 03:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:52 INFO - 'NO_EM_RESTART': '1', 03:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:52 INFO - 'PWD': '/builds/slave/test', 03:49:52 INFO - 'SHELL': '/bin/bash', 03:49:52 INFO - 'SHLVL': '1', 03:49:52 INFO - 'TERM': 'linux', 03:49:52 INFO - 'TMOUT': '86400', 03:49:52 INFO - 'USER': 'cltbld', 03:49:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:52 INFO - '_': '/tools/buildbot/bin/python'} 03:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:49: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 03:49: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 03:49: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 03:49: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 03:49:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:49:54 INFO - Installing collected packages: mozsystemmonitor 03:49:54 INFO - Running setup.py install for mozsystemmonitor 03:49:54 INFO - Successfully installed mozsystemmonitor 03:49:54 INFO - Cleaning up... 03:49:54 INFO - Return code: 0 03:49:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49: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')]} 03:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49: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', '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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:49: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 jsonschema==2.5.1 03:49:54 INFO - Using env: {'DISPLAY': ':0', 03:49:54 INFO - 'HOME': '/home/cltbld', 03:49:54 INFO - 'LANG': 'en_US.UTF-8', 03:49:54 INFO - 'LANGUAGE': 'en_US:en', 03:49:54 INFO - 'LOGNAME': 'cltbld', 03:49:54 INFO - 'MAIL': '/var/mail/cltbld', 03:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:54 INFO - 'MOZ_NO_REMOTE': '1', 03:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:54 INFO - 'NO_EM_RESTART': '1', 03:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:54 INFO - 'PWD': '/builds/slave/test', 03:49:54 INFO - 'SHELL': '/bin/bash', 03:49:54 INFO - 'SHLVL': '1', 03:49:54 INFO - 'TERM': 'linux', 03:49:54 INFO - 'TMOUT': '86400', 03:49:54 INFO - 'USER': 'cltbld', 03:49:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:54 INFO - '_': '/tools/buildbot/bin/python'} 03:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:49:54 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 03:49:54 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 03:49:54 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 03:49:54 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 03:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:49: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 03:49: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 03:49: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 03:49: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 03:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:55 INFO - warning: no files found matching '*.txt' 03:49:55 INFO - no previously-included directories found matching 'build' 03:49:55 INFO - no previously-included directories found matching 'dist' 03:49:55 INFO - no previously-included directories found matching '.git*' 03:49:55 INFO - Installing collected packages: jsonschema, functools32 03:49:56 INFO - Running setup.py install for functools32 03:49:56 INFO - warning: no files found matching '*.txt' 03:49:56 INFO - no previously-included directories found matching 'build' 03:49:56 INFO - no previously-included directories found matching 'dist' 03:49:56 INFO - no previously-included directories found matching '.git*' 03:49:56 INFO - Successfully installed jsonschema functools32 03:49:56 INFO - Cleaning up... 03:49:56 INFO - Return code: 0 03:49:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:56 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49:56 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 03:49:56 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 03:49:56 INFO - Using env: {'DISPLAY': ':0', 03:49:56 INFO - 'HOME': '/home/cltbld', 03:49:56 INFO - 'LANG': 'en_US.UTF-8', 03:49:56 INFO - 'LANGUAGE': 'en_US:en', 03:49:56 INFO - 'LOGNAME': 'cltbld', 03:49:56 INFO - 'MAIL': '/var/mail/cltbld', 03:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:56 INFO - 'MOZ_NO_REMOTE': '1', 03:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:56 INFO - 'NO_EM_RESTART': '1', 03:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:56 INFO - 'PWD': '/builds/slave/test', 03:49:56 INFO - 'SHELL': '/bin/bash', 03:49:56 INFO - 'SHLVL': '1', 03:49:56 INFO - 'TERM': 'linux', 03:49:56 INFO - 'TMOUT': '86400', 03:49:56 INFO - 'USER': 'cltbld', 03:49:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:56 INFO - '_': '/tools/buildbot/bin/python'} 03:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:49:56 INFO - Cleaning up... 03:49:56 INFO - Return code: 0 03:49:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:56 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49:56 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 03:49:56 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 03:49:56 INFO - Using env: {'DISPLAY': ':0', 03:49:56 INFO - 'HOME': '/home/cltbld', 03:49:56 INFO - 'LANG': 'en_US.UTF-8', 03:49:56 INFO - 'LANGUAGE': 'en_US:en', 03:49:56 INFO - 'LOGNAME': 'cltbld', 03:49:56 INFO - 'MAIL': '/var/mail/cltbld', 03:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:56 INFO - 'MOZ_NO_REMOTE': '1', 03:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:56 INFO - 'NO_EM_RESTART': '1', 03:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:56 INFO - 'PWD': '/builds/slave/test', 03:49:56 INFO - 'SHELL': '/bin/bash', 03:49:56 INFO - 'SHLVL': '1', 03:49:56 INFO - 'TERM': 'linux', 03:49:56 INFO - 'TMOUT': '86400', 03:49:56 INFO - 'USER': 'cltbld', 03:49:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:56 INFO - '_': '/tools/buildbot/bin/python'} 03:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:56 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 03:49:56 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 03:49:56 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 03:49:56 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 03:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49: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 03:49: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 03:49: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 03:49: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 03:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:58 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 03:49:58 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 03:49:58 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 03:49:58 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 03:49:58 INFO - Downloading docopt-0.6.1.tar.gz 03:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:58 INFO - Running setup.py install for blobuploader 03:49:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:58 INFO - Running setup.py install for requests 03:49:58 INFO - Running setup.py install for docopt 03:49:58 INFO - Successfully installed blobuploader requests docopt 03:49:58 INFO - Cleaning up... 03:49:58 INFO - Return code: 0 03:49:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:58 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')]} 03:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:58 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')]} 03:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:58 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:49:58 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 03:49:58 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 03:49:58 INFO - Using env: {'DISPLAY': ':0', 03:49:58 INFO - 'HOME': '/home/cltbld', 03:49:58 INFO - 'LANG': 'en_US.UTF-8', 03:49:58 INFO - 'LANGUAGE': 'en_US:en', 03:49:58 INFO - 'LOGNAME': 'cltbld', 03:49:58 INFO - 'MAIL': '/var/mail/cltbld', 03:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:58 INFO - 'MOZ_NO_REMOTE': '1', 03:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:58 INFO - 'NO_EM_RESTART': '1', 03:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:58 INFO - 'PWD': '/builds/slave/test', 03:49:58 INFO - 'SHELL': '/bin/bash', 03:49:58 INFO - 'SHLVL': '1', 03:49:58 INFO - 'TERM': 'linux', 03:49:58 INFO - 'TMOUT': '86400', 03:49:58 INFO - 'USER': 'cltbld', 03:49:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:58 INFO - '_': '/tools/buildbot/bin/python'} 03:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:59 INFO - Running setup.py (path:/tmp/pip-blpDyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:59 INFO - Running setup.py (path:/tmp/pip-8_UPLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:59 INFO - Running setup.py (path:/tmp/pip-pKGlrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:59 INFO - Running setup.py (path:/tmp/pip-VyzwgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:59 INFO - Running setup.py (path:/tmp/pip-_uXlHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:59 INFO - Running setup.py (path:/tmp/pip-Ai_wnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:59 INFO - Running setup.py (path:/tmp/pip-uz7Tvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:59 INFO - Running setup.py (path:/tmp/pip-CPFI3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:59 INFO - Running setup.py (path:/tmp/pip-ijPQwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:59 INFO - Running setup.py (path:/tmp/pip-WIduW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:59 INFO - Running setup.py (path:/tmp/pip-YMVRjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:59 INFO - Running setup.py (path:/tmp/pip-orLcdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:59 INFO - Running setup.py (path:/tmp/pip-ohG97B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:00 INFO - Running setup.py (path:/tmp/pip-9lsdti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:00 INFO - Running setup.py (path:/tmp/pip-gD8K5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:00 INFO - Running setup.py (path:/tmp/pip-FU6CL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:00 INFO - Running setup.py (path:/tmp/pip-FT3qun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:00 INFO - Running setup.py install for manifestparser 03:50:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:00 INFO - Running setup.py install for mozcrash 03:50:00 INFO - Running setup.py install for mozdebug 03:50:00 INFO - Running setup.py install for mozdevice 03:50:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:00 INFO - Running setup.py install for mozfile 03:50:00 INFO - Running setup.py install for mozhttpd 03:50:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:00 INFO - Running setup.py install for mozinfo 03:50:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:00 INFO - Running setup.py install for mozInstall 03:50:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozleak 03:50:01 INFO - Running setup.py install for mozlog 03:50:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for moznetwork 03:50:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozprocess 03:50:01 INFO - Running setup.py install for mozprofile 03:50:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozrunner 03:50:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:01 INFO - Running setup.py install for mozscreenshot 03:50:01 INFO - Running setup.py install for moztest 03:50:01 INFO - Running setup.py install for mozversion 03:50:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:02 INFO - Cleaning up... 03:50:02 INFO - Return code: 0 03:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50: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')]} 03:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:02 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:50:02 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 03:50:02 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 03:50:02 INFO - Using env: {'DISPLAY': ':0', 03:50:02 INFO - 'HOME': '/home/cltbld', 03:50:02 INFO - 'LANG': 'en_US.UTF-8', 03:50:02 INFO - 'LANGUAGE': 'en_US:en', 03:50:02 INFO - 'LOGNAME': 'cltbld', 03:50:02 INFO - 'MAIL': '/var/mail/cltbld', 03:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:02 INFO - 'MOZ_NO_REMOTE': '1', 03:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:02 INFO - 'NO_EM_RESTART': '1', 03:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:02 INFO - 'PWD': '/builds/slave/test', 03:50:02 INFO - 'SHELL': '/bin/bash', 03:50:02 INFO - 'SHLVL': '1', 03:50:02 INFO - 'TERM': 'linux', 03:50:02 INFO - 'TMOUT': '86400', 03:50:02 INFO - 'USER': 'cltbld', 03:50:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:02 INFO - '_': '/tools/buildbot/bin/python'} 03:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:02 INFO - Running setup.py (path:/tmp/pip-JPTK1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:02 INFO - Running setup.py (path:/tmp/pip-ICPnqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:02 INFO - Running setup.py (path:/tmp/pip-UAVXGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:02 INFO - Running setup.py (path:/tmp/pip-8cBSw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:02 INFO - Running setup.py (path:/tmp/pip-iwzAyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:02 INFO - Running setup.py (path:/tmp/pip-yOzkXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:02 INFO - Running setup.py (path:/tmp/pip-iZOYWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:02 INFO - Running setup.py (path:/tmp/pip-uvpdIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:02 INFO - Running setup.py (path:/tmp/pip-70ht2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:02 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)) 03:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:02 INFO - Running setup.py (path:/tmp/pip-RNsUSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:03 INFO - Running setup.py (path:/tmp/pip-lTP7yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:03 INFO - Running setup.py (path:/tmp/pip-FtMaVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:03 INFO - Running setup.py (path:/tmp/pip-9PTbRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:03 INFO - Running setup.py (path:/tmp/pip-QHn3Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:03 INFO - Running setup.py (path:/tmp/pip-YWLCuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:03 INFO - Running setup.py (path:/tmp/pip-Uj0QJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:03 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)) 03:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:03 INFO - Running setup.py (path:/tmp/pip-NQ0z5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 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)) 03:50:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:04 INFO - Downloading blessings-1.6.tar.gz 03:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:04 INFO - Installing collected packages: blessings 03:50:04 INFO - Running setup.py install for blessings 03:50:04 INFO - Successfully installed blessings 03:50:04 INFO - Cleaning up... 03:50:04 INFO - Return code: 0 03:50:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:05 INFO - Reading from file tmpfile_stdout 03:50:05 INFO - Current package versions: 03:50:05 INFO - argparse == 1.2.1 03:50:05 INFO - blessings == 1.6 03:50:05 INFO - blobuploader == 1.2.4 03:50:05 INFO - docopt == 0.6.1 03:50:05 INFO - functools32 == 3.2.3-2 03:50:05 INFO - jsonschema == 2.5.1 03:50:05 INFO - manifestparser == 1.1 03:50:05 INFO - mozInstall == 1.13 03:50:05 INFO - mozcrash == 1.0 03:50:05 INFO - mozdebug == 0.1 03:50:05 INFO - mozdevice == 0.51 03:50:05 INFO - mozfile == 1.2 03:50:05 INFO - mozhttpd == 0.7 03:50:05 INFO - mozinfo == 0.10 03:50:05 INFO - mozleak == 0.1 03:50:05 INFO - mozlog == 3.5 03:50:05 INFO - moznetwork == 0.27 03:50:05 INFO - mozprocess == 0.25 03:50:05 INFO - mozprofile == 0.28 03:50:05 INFO - mozrunner == 6.13 03:50:05 INFO - mozscreenshot == 0.1 03:50:05 INFO - mozsystemmonitor == 0.3 03:50:05 INFO - moztest == 0.8 03:50:05 INFO - mozversion == 1.4 03:50:05 INFO - psutil == 3.1.1 03:50:05 INFO - requests == 1.2.3 03:50:05 INFO - wsgiref == 0.1.2 03:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50: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')]} 03:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:05 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:50:05 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 03:50:05 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 03:50:05 INFO - Using env: {'DISPLAY': ':0', 03:50:05 INFO - 'HOME': '/home/cltbld', 03:50:05 INFO - 'LANG': 'en_US.UTF-8', 03:50:05 INFO - 'LANGUAGE': 'en_US:en', 03:50:05 INFO - 'LOGNAME': 'cltbld', 03:50:05 INFO - 'MAIL': '/var/mail/cltbld', 03:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:05 INFO - 'MOZ_NO_REMOTE': '1', 03:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:05 INFO - 'NO_EM_RESTART': '1', 03:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:05 INFO - 'PWD': '/builds/slave/test', 03:50:05 INFO - 'SHELL': '/bin/bash', 03:50:05 INFO - 'SHLVL': '1', 03:50:05 INFO - 'TERM': 'linux', 03:50:05 INFO - 'TMOUT': '86400', 03:50:05 INFO - 'USER': 'cltbld', 03:50:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:05 INFO - '_': '/tools/buildbot/bin/python'} 03:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 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)) 03:50:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:50:05 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 03:50:05 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 03:50:05 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 03:50:05 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 03:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:50:06 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)) 03:50:06 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)) 03:50:06 INFO - Installing collected packages: simplejson 03:50:06 INFO - Running setup.py install for simplejson 03:50:06 INFO - building 'simplejson._speedups' extension 03:50:06 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 03:50:07 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 03:50:07 INFO - Successfully installed simplejson 03:50:07 INFO - Cleaning up... 03:50:07 INFO - Return code: 0 03:50:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:07 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 0x11d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15409c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, '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': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', '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 03:50:07 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 03:50:07 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 03:50:07 INFO - Using env: {'DISPLAY': ':0', 03:50:07 INFO - 'HOME': '/home/cltbld', 03:50:07 INFO - 'LANG': 'en_US.UTF-8', 03:50:07 INFO - 'LANGUAGE': 'en_US:en', 03:50:07 INFO - 'LOGNAME': 'cltbld', 03:50:07 INFO - 'MAIL': '/var/mail/cltbld', 03:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:07 INFO - 'MOZ_NO_REMOTE': '1', 03:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:07 INFO - 'NO_EM_RESTART': '1', 03:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:07 INFO - 'PWD': '/builds/slave/test', 03:50:07 INFO - 'SHELL': '/bin/bash', 03:50:07 INFO - 'SHLVL': '1', 03:50:07 INFO - 'TERM': 'linux', 03:50:07 INFO - 'TMOUT': '86400', 03:50:07 INFO - 'USER': 'cltbld', 03:50:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:07 INFO - '_': '/tools/buildbot/bin/python'} 03:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:07 INFO - Cleaning up... 03:50:07 INFO - Return code: 0 03:50:07 INFO - Running post-action listener: _resource_record_post_action 03:50:07 INFO - Running post-action listener: _start_resource_monitoring 03:50:07 INFO - Starting resource monitoring. 03:50:07 INFO - [mozharness: 2017-09-25 10:50:07.806461Z] Finished create-virtualenv step (success) 03:50:07 INFO - [mozharness: 2017-09-25 10:50:07.806984Z] Running install step. 03:50:07 INFO - Running pre-action listener: _resource_record_pre_action 03:50:07 INFO - Running main action method: install 03:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:08 INFO - Reading from file tmpfile_stdout 03:50:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:08 INFO - Reading from file tmpfile_stdout 03:50:08 INFO - Output received: 03:50:08 INFO - Usage: mozinstall [options] installer 03:50:08 INFO - Options: 03:50:08 INFO - -h, --help show this help message and exit 03:50:08 INFO - -d DEST, --destination=DEST 03:50:08 INFO - Directory to install application into. [default: 03:50:08 INFO - "/builds/slave/test"] 03:50:08 INFO - --app=APP Application being installed. [default: firefox] 03:50:08 INFO - mkdir: /builds/slave/test/build/application 03:50:08 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'] 03:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:50:25 INFO - Reading from file tmpfile_stdout 03:50:25 INFO - Output received: 03:50:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:50:25 INFO - Running post-action listener: _resource_record_post_action 03:50:25 INFO - [mozharness: 2017-09-25 10:50:25.952079Z] Finished install step (success) 03:50:25 INFO - [mozharness: 2017-09-25 10:50:25.952200Z] Running setup-mitmproxy step. 03:50:25 INFO - Running pre-action listener: _resource_record_pre_action 03:50:25 INFO - Running main action method: setup_mitmproxy 03:50:25 INFO - Skipping: mitmproxy is not required 03:50:25 INFO - Running post-action listener: _resource_record_post_action 03:50:25 INFO - [mozharness: 2017-09-25 10:50:25.952740Z] Finished setup-mitmproxy step (success) 03:50:25 INFO - [mozharness: 2017-09-25 10:50:25.952854Z] Running run-tests step. 03:50:25 INFO - Running pre-action listener: _resource_record_pre_action 03:50:25 INFO - Running pre-action listener: _set_gcov_prefix 03:50:25 INFO - Running main action method: run_tests 03:50:25 WARNING - Try message not found. 03:50:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:50:25 INFO - Python 2.7.3 03:50:25 INFO - Return code: 0 03:50:25 INFO - grabbing minidump binary from tooltool 03:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:25 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 0x153dd60>, '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 0x153ea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153eef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:50:25 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 03:50:25 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 03:50:25 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 03:50:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:50:26 INFO - Return code: 0 03:50:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:50:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - ENV: RUST_BACKTRACE is now full 03:50:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:50:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:50:26 INFO - Using env: {'DISPLAY': ':0', 03:50:26 INFO - 'HOME': '/home/cltbld', 03:50:26 INFO - 'LANG': 'en_US.UTF-8', 03:50:26 INFO - 'LANGUAGE': 'en_US:en', 03:50:26 INFO - 'LOGNAME': 'cltbld', 03:50:26 INFO - 'MAIL': '/var/mail/cltbld', 03:50:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:26 INFO - 'MOZ_NO_REMOTE': '1', 03:50:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:26 INFO - 'NO_EM_RESTART': '1', 03:50:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:26 INFO - 'PWD': '/builds/slave/test', 03:50:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:26 INFO - 'RUST_BACKTRACE': 'full', 03:50:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:26 INFO - 'SHELL': '/bin/bash', 03:50:26 INFO - 'SHLVL': '1', 03:50:26 INFO - 'TERM': 'linux', 03:50:26 INFO - 'TMOUT': '86400', 03:50:26 INFO - 'USER': 'cltbld', 03:50:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:26 INFO - '_': '/tools/buildbot/bin/python'} 03:50:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:50:26 INFO - mozversion application_buildid: 20170925095628 03:50:26 INFO - mozversion application_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:50:26 INFO - mozversion application_display_name: Nightly 03:50:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:50:26 INFO - mozversion application_name: Firefox 03:50:26 INFO - mozversion application_remotingname: firefox 03:50:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:50:26 INFO - mozversion application_vendor: Mozilla 03:50:26 INFO - mozversion application_version: 58.0a1 03:50:26 INFO - mozversion platform_buildid: 20170925095628 03:50:26 INFO - mozversion platform_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:50:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:50:26 INFO - mozversion platform_version: 58.0a1 03:50:26 INFO - using testdate: 1506336626 03:50:26 INFO - actual date: 1506336626 03:50:26 INFO - starting webserver on 'localhost:37352' 03:50:26 INFO - SUITE-START | Running 2 tests 03:50:26 INFO - TEST-START | dromaeo_css 03:50:26 INFO - Initialising browser for dromaeo_css test... 03:50:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37352/getInfo.html -profile /tmp/tmpSkIe6f/profile 03:50:26 INFO - TEST-INFO | started process 9435 (/builds/slave/test/build/application/firefox/firefox http://localhost:37352/getInfo.html) 03:50:31 INFO - TEST-INFO | 9435: exit 0 03:50:31 INFO - Browser initialized. 03:50:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:31 INFO - Using env: {'DISPLAY': ':0', 03:50:31 INFO - 'HOME': '/home/cltbld', 03:50:31 INFO - 'JSGC_DISABLE_POISONING': '1', 03:50:31 INFO - 'LANG': 'en_US.UTF-8', 03:50:31 INFO - 'LANGUAGE': 'en_US:en', 03:50:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:50:31 INFO - 'LOGNAME': 'cltbld', 03:50:31 INFO - 'MAIL': '/var/mail/cltbld', 03:50:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:31 INFO - 'MOZ_CRASHREPORTER': '1', 03:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:50:31 INFO - 'MOZ_NO_REMOTE': '1', 03:50:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:31 INFO - 'NO_EM_RESTART': '1', 03:50:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:31 INFO - 'PWD': '/builds/slave/test', 03:50:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:31 INFO - 'RUST_BACKTRACE': 'full', 03:50:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:31 INFO - 'SHELL': '/bin/bash', 03:50:31 INFO - 'SHLVL': '1', 03:50:31 INFO - 'STYLO_FORCE_DISABLED': '1', 03:50:31 INFO - 'TERM': 'linux', 03:50:31 INFO - 'TMOUT': '86400', 03:50:31 INFO - 'USER': 'cltbld', 03:50:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 03:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:31 INFO - '_': '/tools/buildbot/bin/python'} 03:50:31 INFO - TEST-INFO | started process 9668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSkIe6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:32 INFO - PID 9668 | 03:50:32 INFO - PID 9668 | (/builds/slave/test/build/application/firefox/firefox:9718): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:32 INFO - PID 9668 | 03:50:42 INFO - PID 9668 | RSS: Main: 153092096 03:50:42 INFO - PID 9668 | 03:53:39 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37352/tests/dromaeo/cssquery-ext.html) 03:53:40 INFO - PID 9668 | RSS: Main: 153976832 03:53:40 INFO - PID 9668 | 03:56:42 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-ext.html (next: http://localhost:37352/tests/dromaeo/cssquery-jquery.html) 03:56:43 INFO - PID 9668 | RSS: Main: 154206208 03:56:43 INFO - PID 9668 | 03:59:44 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37352/tests/dromaeo/cssquery-mootools.html) 03:59:45 INFO - PID 9668 | RSS: Main: 155865088 03:59:45 INFO - PID 9668 | 04:02:47 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37352/tests/dromaeo/cssquery-prototype.html) 04:02:47 INFO - PID 9668 | RSS: Main: 154652672 04:02:47 INFO - PID 9668 | 04:05:50 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37352/tests/dromaeo/cssquery-yui.html) 04:05:51 INFO - PID 9668 | RSS: Main: 156123136 04:05:51 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | Cycle 1(1): loaded http://localhost:37352/tests/dromaeo/cssquery-yui.html (next: http://localhost:37352/tests/dromaeo/cssquery-dojo.html) 04:08:53 INFO - PID 9668 | RSS: Main: 157818880 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | __start_tp_report 04:08:53 INFO - PID 9668 | _x_x_mozilla_page_load 04:08:53 INFO - PID 9668 | _x_x_mozilla_page_load_details 04:08:53 INFO - PID 9668 | |i|pagename|runs| 04:08:53 INFO - PID 9668 | |0;dojo.html;3126.140311414361;3128.9061328160155;3170.5878235829337;3183.1087295557254;3191.5053166759144;6163.660998645073;6318.905216421757;6338.936610633892;6371.681415929203;6452.516061295404;6286.277078136016;6309.400606942345;6317.968410157954;6325.146105275787;6351.269603995542;5754.65472071675;5794.884102317951;5907.822765317026;5911.201987731644;5920.91118633222;5736.996025695507;5933.6439813611105;5937.346891841894;6038.939610603904;6047.848803779897;5727.856803579923;5781.103928891008;5858.033424484955;5910.202122713422;5931.139984702194;5848.532117430638;5858.091995740667;5922;5954.136650185742;5956.761729530814;5656.604037717361;5753.88492230153;5762.135679648044;5770.336411312669;5894.823155305347;6164;6324.177856878622;6331.240251169889;6385.361463853624;6387.233531976192;6829.658517074176;6852.45180385573;6855.862882742367;6857.759978400732;6861.725530978755;6807.489438292098;6816.454683625348;6832.624205668686;6887.827804304882;6909.447244220501;6250;6302.842428939267;6345.270293916166;6350.777722779727;6417.294097649255;6981.89527157093;7013.964930175316;7040.788776336718;7065.752698655522;7072.540284881569;6656.73373065072;6671.266160722316;6728.865422691617;6732.831679208059;6766.627835469097;6796.932030679729;6828.146481689789;6857.828554286083;6887.414569761627;6911.136107986502;6476.093346931433;6556.508261880378;6570.967145164243;6581.3418658133805;6584.473242140617;6718.49611279156;6762.830929226809;6838.48711346651;6849.109615750021;6850.143732033496;5229.372475302912;5277.393099793573;5316.9202461963105;5317.973410133002;5320.388155362106;4620.283856002325;4626.236670949255;4643.930341044887;4671.18254305502;4717.985633088902;5729.197912292282;5823.56323275756;5850.707464626752;5904.645721256738;5911.349751527328;6765.729370825112;6805.217399999064;6877.277885821916;6883.036374907517;6885.758998435031;5830;5869.266341707286;5898.970505147533;5924.496417804535;5930.28836539618;5799.768009279582;5810.389909059572;5875.030619947661;5883;5897.823065308047;6245.0632405139595;6578;6587;6650.567713098633;6660.167479065117;6741.932580674229;6750.594964302158;6765.255821859493;6846.7945961621235;6851;6540.967295163494;6603.603783772989;6618.106555614931;6623.834404139935;6623.867522649423;6704.4301234395625;6787;6807.727690892309;6812.352826481477;6812.965935170292;6811.761588344384;6813.659317034029;6907.585544867324;6916.377526022682;6929.099217101744;6426.4216220540375;6532.738690452328;6547.639879806657;6547.803565893031;6568.868622627616;6538.673066346759;6603;6603.372679595431;6694.83262918431;6705.430038446591;6502.187226596676;6561.934380656323;6564.310747371648;6569.507286953402;6573.112629795108;6617.470602351897;6629.7348106075215;6660.367265109807;6662.933370666426;6749.628770417477;6272.717727702356;6378.48972082223;6413.1021656969;6496.675166241764;6497.837554061186 04:08:53 INFO - PID 9668 | |1;ext.html;856.4775486952962;887.2635712358741;912.4844462878469;914.2046419614932;920.3235621817963;39578.60421395785;41951.370729439004;42069.36895946563;42228.78885605572;42389.36415953763;39175.60824391755;39290.21419571607;39535.209295814064;39541;39576.80211598945;7233.819154521127;7360.484766066377;7365.410767138616;7373.926260737405;7384.409247260206;7240.746573869916;7314.743983960562;7315.231900650435;7317.121945366537;7400.222976587462;7284.380827629658;7337.0461839961;7370.705171793122;7374.410047196211;7857.371410287164;7961.681532738684;8028.317593004544;8030.9196908031045;8033.1163572007035;8039.276465118168;7841.725539606144;7941.5632140232265;7945.205479452008;7945.562994035326;7949.284564389175;38919.805400972815;39196;39355.606443935765;40115.59884401148;40126.79936600327;3591.3356029134434;3634.509341238952;3640.21735326906;3641.563012438498;3641.5630124385243;32465.35069298601;32771.50842737361;32791.344173116406;32792;32795.34409311824;5113.079645663779;5147.330846989905;5153.948460515385;5191.844244672666;5252.763625636855;188104;189312;189424;189624.0518797411;190254;50576;50593.24110138351;50598.24102638463;50619.49380506148;50654.49345506498;51793.7410312946;52068.479315206365;52331;52362.73818630882;52381.7380913093;15239.466618668293;15597.064176149468;15609.60975975587;15643.374265029499;15647.374105035671;12391.194572352768;12443.066769992287;12480.750384992249;12485.126041177213;12523.123381363217;14127.929360353133;14198.148111113367;14289.927960445677;14334.068285561405;14425.42298308056;5750.741216645261;5804.6807425592;5859.150423188614;5903.675297858573;5936.287645482484;999.9950000249952;1003.5634498992962;1018.312638968708;1021.4790456867051;1028.0798685176726;23149.652755208685;23238.070477181063;23361.934282704904;23381;23601.40996475102;1111.2776695148218;1112.4993752811267;1127.7293449572044;1128.9774204515863;1129.6554550862065;12343.629691109281;12432.191907525981;12447;12543.24740515572;12548.686282843002;223647;223741;224651;224775;225140;46061;46647.76676116598;51831.22253166205;53092.46907530953;53368;1476.1290838405391;1481.64440534271;1486.2568715642394;1486.762118061105;1492.1942151238427;26749.866250668623;26957.865210673823;27093;27128.593071103554;27213;37653;37741.62258377381;37856.62143378531;37972;37995.81002094972;189731;191237;191482;191661;192216;34625;35452.46821297734;35937.46093808542;35958.46062309015;36013.639863602075;44303;45086.77456612696;45488.09023819571;45498.54501454943;45648.31527527023;32026.35947280995;32269.838650806596;32326.19184520406;32348.514772277966;32829.34341313112;32376;32520.83739581287;32555.511667324536;32564;32705;36658.8167059163;37068.25863482769;37174.814125929195;37198.814005929795;37403.81298093492;31813.840930796123;32002.51996220012;32133.839330803195;32231.838840805645;32499.837500812344;23445.41386465352;23630.17294394688;23890.283291501284;24003.759962400152;24088.036478540664 04:08:53 INFO - PID 9668 | |2;jquery.html;599.4904331318377;603.4177019176495;603.4327731931986;608.1880689279811;609.3997412548641;21800.345989620317;22517.211897583587;22697.773022269794;22715.864206789676;22744.090236390526;22246.221382251624;23913.521729565397;24115.517689646196;24166.275011749676;24297.028118875267;6526.053722210277;6686;6716.832079198035;6717.63053032083;6728.764493242737;6282.183316168892;6564.638944858031;6585.209774827027;6596.505262105337;6639.5684280521855;6583.967080164616;6612.867742645144;6630.767923122692;6634.038064480672;6641.435477984377;6215.378462153816;6480.287168411471;6491.610503369766;6553.377429144223;6588.143541339619;6015.0375939849855;6033.034714445667;6034.185384973016;6053.878922421527;6062.878742425127;28017.71982280192;28177;28261.293467663472;28503.85748071267;28615.856920715472;2013.1242909334487;2032.4715573950732;2040.3776848061336;2041.9183232670675;2047.4267205182573;18027.459176224733;18395;18682.532936676555;18841.90579047096;18845.151968161466;2402.519496100769;2450.9950920122665;2465.0509553821908;2468.691413573303;2515.9874200629065;115586;123549;138244;142767;143198.2840085793;14737.410503579951;14866.851331486763;14870.479533216501;14903.584159505046;15216.01095928761;23534;23664.17175398853;23680.881595591913;23711.288661340186;23754.406139846644;10314.27800053989;10516.789664206826;10532.578696852193;10571.312864663772;10601.098906593026;9639.518024098767;9762.90237097634;9796.608135674636;9798.559064842098;9853.40879547215;9005.684801031932;9131;9180.21968132703;9295.349325547282;9373.812523749486;2737.2609395463114;2741.5613501840007;2784.443111377692;2790.944181116407;2801.9859900700367;964.1178321835582;971.9319647624599;982.3320142303303;995.3032876986139;995.9751006224758;18398.724019139725;18527.90736046338;18653.347132850286;18934.810651893582;19062.61874762525;1026.0662796854826;1034.8085604163255;1045.7072019834459;1054.1145437832258;1067.2315932528568;10233.283670143168;10378.688639340831;10419.322744021614;10550.261481696361;10577.788444231071;462027;464430.2145974258;471460;475180;480446;112830.43584782023;115841;117913;117987;117991.41004294924;1075.2526993739275;1167.8890505401973;1173.906087512997;1225.1424003197797;1227.2759072147476;19457.221711131395;19731.704024439357;20047.198112075355;20077.698834517785;20173.59652806965;55662.443375567345;56907.43092569021;56909.43090569207;57501.4249857496;58000.4199957995;67661.66169169123;68344.3165568338;69765;70736.64631676809;71681;14069.366878490287;14215.360308785923;14253.928730356281;14333.928330358282;14373.712525749635;22001.339959801233;22200.666989995487;22243.22148724787;22604.886975565016;22672.886635566716;17505.912470437564;17982.37061702834;18053.277868885096;18140.90929545344;18154.636907262044;15906.9204653976;16090.873638845169;16259.268332925283;16490.670186596442;16774.32902683879;17727.645447091243;17754.733678994566;17799.110044497982;17805.306554333307;18239.726404104214;14109.929450352682;14127.858721412655;14132;14198.00613957013;14212.502562410265;17556.82443175603;17713.380031698827;17713.380031699344;17974.91012544929;18172.545686357946 04:08:53 INFO - PID 9668 | |3;mootools.html;1331.3609467455622;1421.7440860645079;1426.6433391652083;1439.654482924098;1445.551878917535;12823.48706051758;13439.260840653773;15577.766333505006;16146.596335091599;16178.676426471464;15475.30361133749;15764.211789410541;15795.289211985459;15797.60505987351;15807.446739364124;2483.4908843687;2815.197668664431;2817.929551761212;2838.3329917469378;2877.6690680571687;2874.755645770112;2901.3036871150875;2902.2018944790248;2902.2599237194486;2903.187107609862;2332.4052366646565;2775.8056936014486;2860.199144239616;2862.8711707973193;2865.298001989505;2820.1539538138477;2848.7720982321366;2851.4012057467958;2863.871125799344;2867.9283017924613;2708.891644334224;2718.972810271892;2735.8084934054623;2754.0223220756743;2765.5298599238176;15134.016288941293;15520.5343839685;15605.687886242325;15623.687526249412;15630.374785008586;7963.601819908981;8195.098539160688;8234.547099909563;8241.83516329676;8272;5360.2227676987;5511.285224591556;5590.8043218487155;5612.803551875665;5659.4340565943485;1924.5092501412191;2006.3579654510563;2015.8185763281374;2051.1590247998397;2059.588082383529;26338.736612633627;28181;28184;28393.290167745767;28478.715212847812;7234.927650723531;7262.5111852070195;7356.204642235916;7461.246607047339;7489.737859174903;17964.730529042074;17970.640587188445;17983.910080449514;18008.279668813364;18017.099145042695;7946.920530794734;8091.393145513992;8131.5363234618335;8138.145494723087;8159.714409995621;7489.28851759082;7541.2458754124145;7642.8089297768;7774.1837107104075;7781.572013539309;5391.595630327663;5434.728263586805;5563.499285064364;5601.215829783833;5613.326400831927;1640.7456844189169;1656.7017936771497;1658.5107393319;1665.808432030332;1681.9327226910787;886.6586364249811;898.5237823953315;907.9319051071196;909.9681511147078;917.3211823250747;7479.551226926402;7526.32263096324;7531.661075251627;7552.39580833543;7592.354649854714;721.1166321256419;743.598456833304;748.4498893313411;751.4814777803298;765.9004329437138;4618.30725391194;4974.676646017997;5226.477352264819;5331.1470164773455;5356.330458692663;22129.114835406726;22808.20171293997;23117.422064448187;23138.768612313663;23376.64935025976;21408.78591214099;22682.319530413784;22684.432889177904;22718.659220111713;23083;9667.661631842851;11784.646460606196;11995.520179192734;12183.329916854658;12195.756084878252;7187.676554554953;9131;9152.17630413266;9191.21874640663;9212.723618291462;18082.095895204922;18666.813331866506;18716.812831871506;19493.999999999432;19852.60294794125;19380.612387752448;19819.20723171057;19847;19883.105260263033;20033.699494507884;10587.788244235226;10623.89376106229;10713.517891694737;10721.624743133953;10761.569537218424;14175.574732758034;14192.290385480479;14197.219152946687;14232.430702771773;14257.64355891111;10957.287776294515;11069.612563560559;11110.666679999613;11360.204785664924;11523.654290371302;11190.32858028521;11491.482883270106;11506.94246528762;11554;11999.460024298753;9631.759206019906;9690.612375504901;9735.70792876215;9737.561809718722;9742;7378.5941773202985;7412.740554080581;7418.443616728875;7439.442041846992;7483.176850546544;7624.771256862303;7632.122305934889;7640.426967977312;7695.23047695226;7771.961140194263 04:08:53 INFO - PID 9668 | |4;prototype.html;508.70826924704227;535.8238666127849;536.9838904832854;538.1631562919661;548.5145646103202;6108.816735497942;6188.195534580509;6259.405356491132;6261.937380626192;6294.339094395085;6101.230643113492;6105.786297479589;6123.173371594833;6168.876622467548;6205.596636218643;5107.693538387709;5126.384833819928;5169.121249387595;5175.353080864892;5193.5325820676135;4835.951640483585;5140.871478213037;5153.974230128844;5157.7936882524655;5214.843554693346;4910.533499317559;4944.381952255968;4966.428860681014;4984.825531106412;5008.874778130557;4931.284963680282;4954.578860796837;4955.529224723646;4961.305417241589;5008.449070602231;4462.419885414875;4479.283314669669;4479.305707615293;4498.955010449887;4516.774161291923;6055.909161362583;6080.939190608082;6147.784827531015;6148.96925515374;6161.075838624198;5688.4311568843195;5713.485786279255;5733.283339582552;5742.253507044057;5782.161586569966;6438.549301548894;6447;6468.1268028815975;6492.350764923517;6555.737770489175;4811.927821082687;4837.346958160639;4845.563899249085;4846.709197448165;4867.586255168279;6417.422431981144;6664.700088496029;6675.432588230006;6709.597424154566;6714.89204281293;4939.678920870132;4951.628627852925;4955.380577427822;4979.850604481871;4997.85006449807;5046.873828154326;5058.570021548209;5077.263796749525;5078.0703332734065;5108.923366149511;5593.636413633101;5677.489025987681;5686.857828554319;5691.658500489983;5743.195952566644;6465.418112369909;6571.868562628816;6592.670366481752;6596.944488881852;6609.306022867626;1752.3516298969207;1763.5943732941496;1764.3560100563202;1765.382116259299;1768.7081631530652;1159.1943599198644;1226.8405107335989;1229.2317301686446;1233.463443402123;1244.5270797097046;5521.806736764274;5566.775309431919;5650.7174641267775;5655.349634791969;5723.540497173194;6545.541812073205;6553.017047442826;6590.703418346186;6650.235222949326;6653.1018312527185;5528.889422211614;5582.8325150245555;5670.376258611632;5674.2339784129435;5727.284089488814;3430.6740859618294;3457.856129199912;3474.2877710069374;3479.9652003480146;3525.5016617937786;6352.8411789704705;6376.29860715321;6396.0725694774;6409.615423074631;6477.611343319416;6218.844528886723;6753.493487988322;6764.3573860483175;6826;6828.692708828015;6261.248650161919;6277.968610157011;6293.3391993840905;6392.274085996755;6414.454771344488;6450.41946224842;6512;6513.934860651333;6518.924377477663;6583.967080164569;6506.512011599054;6594.769183078569;6661.666916654051;6689.929611262175;6695.866082678222;6389.265234497906;6423.229212494531;6463.385978332051;6470.838229044311;6488.253850807028;4855.854324370274;4922.556969872729;4945.91189938213;5003.149464590955;5005.374328208974;6201.627902325875;6481.837954051187;6533.640649764308;6623.635700036544;6695.899561506679;6460.4508616766225;6483.675816209265;6546.770863019771;6551.80344589663;6559.508036897348;6353.618782873043;6381.202349706286;6388.169537960035;6419.2938776735455;6428.164338636135;6339.5562310637815;6364.6181229126405;6376.585521941059;6383.521235907233;6392.808215753535;6416.935830641821;6461.547691661539;6488.902666459912;6520.543561950618;6567.704453299518;6291.496680265476;6314.336994615683;6323.272823625158;6339.7954388666;6411.871762564816 04:08:53 INFO - PID 9668 | |5;yui.html;881.2465342132481;904.7964208053187;915.5925613102168;924.6162842420391;936.9484678342691;19753.802461975374;20315.796842031574;20431.080601372938;20437.897810510927;20440.977951102443;18449.169787359566;18659.813401865977;18917.243310267608;18977.52556186096;19070.141843617035;957.4207604399326;968.7529679931642;968.8643589897384;970.4177493503912;972.8735264415616;933.9626414943428;987.866638003871;992.6376872441543;992.925530585209;993.9006099390075;1029.8712660917386;1039.9844002339971;1042.6976176908724;1043.0143514378915;1044.0551301072542;1033.4987531047436;1033.89144139865;1035.073609119841;1035.5340096956363;1039.049269918028;699.1121275979477;721.7041013184569;725.8947452619393;726.985854732645;727.2727272727273;19975.200991960304;20112.39662810118;20145.496362590908;20158.79841201584;20190.394288171377;21506;21560.245391411383;22638.320850374515;22644.773552264596;22649.660255096187;17694.734578981326;17890.373836915776;18059;18185.909070454694;18216.180271887795;3803.7337386382965;3810.333191691471;3827.158025234444;3828.4257361395735;3840.1551658635058;135398;136749;137386;138243;138640;16459.25933333003;16646.50060498187;16877.240524176443;16974.660506790042;17120.40078597243;31201.219969500944;31622.525662115087;31783.205419864225;31965.840170798998;31991.20021999422;8472.02571704262;8545.401821872409;8550.059493455716;8553;8558.529280889486;4335.284678028153;4344.066025804467;4465.843695470708;4512.300593408027;4561.7262964222255;5546.69493177871;5710.114932185518;5717.514011309002;5729.427057294321;5743.569232307594;988.7528117970508;998.9511013435863;1016.9440680762481;1022.974425639365;1023.2581378500528;697.490831692867;709.9396551293095;719.3993015831735;720.330093013492;721.3976329764705;11244.26912250701;11514.827277590843;11536.94231528837;12515.624531264077;12679.23924564529;665.5341261117237;679.4157024958532;682.3858527325447;694.1427337238506;699.9370056694922;5100.795968161232;5240.187770895517;5268.841934741964;5329.760160792774;5337.973310133424;122517;122954;123198;123361;126052;105455.4727226359;108079.45960270305;108205;110358.44820775845;110451;96057;96150.51924740331;96771;98653;98666;10004.499775011365;10117.949410253195;10198.490075496344;10342.896571034193;10357.482125893826;42360.78819605882;42386.152276954905;43252.78373608112;43704.56295437132;43789.78105109454;54444.18333724918;54975;55283;55788.16317755318;55948.72025639846;15202.695946081238;15561.066336019874;15707.214639268219;15723;15736.134512601917;16734.665306693554;16977.66044679124;17135.05757183367;17143.57141071483;17230.827691722923;15129.773053404428;15185.392584296504;15253.542393728207;15312.540623780858;15315.923420382827;14948.402063917756;15069.924650376677;15076.246187690791;15199;15256.694866102394;14405.351759170653;14411.279436028366;14654.926725366306;14684.632884177554;14728.337224824694;11322.773544528898;11508.079353651856;11578;11667.941660291644;11705;10934.343939363664;11038.944805275922;11078.944605277244;11247.268927519684;11537.423128843691 04:08:53 INFO - PID 9668 | __end_tp_report 04:08:53 INFO - PID 9668 | __start_cc_report 04:08:53 INFO - PID 9668 | _x_x_mozilla_cycle_collect,299 04:08:53 INFO - PID 9668 | __end_cc_report 04:08:53 INFO - PID 9668 | __startTimestamp1506337733318__endTimestamp 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | ------- Summary: start ------- 04:08:53 INFO - PID 9668 | Number of tests: 6 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#0] dojo.html Cycles:165 Average:6248.38 Median:6497.84 stddev:755.65 (11.6%) stddev-sans-first:717.17 04:08:53 INFO - PID 9668 | Values: 3126.1 3128.9 3170.6 3183.1 3191.5 6163.7 6318.9 6338.9 6371.7 6452.5 6286.3 6309.4 6318.0 6325.1 6351.3 5754.7 5794.9 5907.8 5911.2 5920.9 5737.0 5933.6 5937.3 6038.9 6047.8 5727.9 5781.1 5858.0 5910.2 5931.1 5848.5 5858.1 5922.0 5954.1 5956.8 5656.6 5753.9 5762.1 5770.3 5894.8 6164.0 6324.2 6331.2 6385.4 6387.2 6829.7 6852.5 6855.9 6857.8 6861.7 6807.5 6816.5 6832.6 6887.8 6909.4 6250.0 6302.8 6345.3 6350.8 6417.3 6981.9 7014.0 7040.8 7065.8 7072.5 6656.7 6671.3 6728.9 6732.8 6766.6 6796.9 6828.1 6857.8 6887.4 6911.1 6476.1 6556.5 6571.0 6581.3 6584.5 6718.5 6762.8 6838.5 6849.1 6850.1 5229.4 5277.4 5316.9 5318.0 5320.4 4620.3 4626.2 4643.9 4671.2 4718.0 5729.2 5823.6 5850.7 5904.6 5911.3 6765.7 6805.2 6877.3 6883.0 6885.8 5830.0 5869.3 5899.0 5924.5 5930.3 5799.8 5810.4 5875.0 5883.0 5897.8 6245.1 6578.0 6587.0 6650.6 6660.2 6741.9 6750.6 6765.3 6846.8 6851.0 6541.0 6603.6 6618.1 6623.8 6623.9 6704.4 6787.0 6807.7 6812.4 6813.0 6811.8 6813.7 6907.6 6916.4 6929.1 6426.4 6532.7 6547.6 6547.8 6568.9 6538.7 6603.0 6603.4 6694.8 6705.4 6502.2 6561.9 6564.3 6569.5 6573.1 6617.5 6629.7 6660.4 6662.9 6749.6 6272.7 6378.5 6413.1 6496.7 6497.8 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#1] ext.html Cycles:180 Average:37507.61 Median:3637.36 stddev:52349.12 (1439.2%) stddev-sans-first:52423.63 04:08:53 INFO - PID 9668 | Values: 856.5 887.3 912.5 914.2 920.3 39578.6 41951.4 42069.4 42228.8 42389.4 39175.6 39290.2 39535.2 39541.0 39576.8 7233.8 7360.5 7365.4 7373.9 7384.4 7240.7 7314.7 7315.2 7317.1 7400.2 7284.4 7337.0 7370.7 7374.4 7857.4 7961.7 8028.3 8030.9 8033.1 8039.3 7841.7 7941.6 7945.2 7945.6 7949.3 38919.8 39196.0 39355.6 40115.6 40126.8 3591.3 3634.5 3640.2 3641.6 3641.6 32465.4 32771.5 32791.3 32792.0 32795.3 5113.1 5147.3 5153.9 5191.8 5252.8 188104.0 189312.0 189424.0 189624.1 190254.0 50576.0 50593.2 50598.2 50619.5 50654.5 51793.7 52068.5 52331.0 52362.7 52381.7 15239.5 15597.1 15609.6 15643.4 15647.4 12391.2 12443.1 12480.8 12485.1 12523.1 14127.9 14198.1 14289.9 14334.1 14425.4 5750.7 5804.7 5859.2 5903.7 5936.3 1000.0 1003.6 1018.3 1021.5 1028.1 23149.7 23238.1 23361.9 23381.0 23601.4 1111.3 1112.5 1127.7 1129.0 1129.7 12343.6 12432.2 12447.0 12543.2 12548.7 223647.0 223741.0 224651.0 224775.0 225140.0 46061.0 46647.8 51831.2 53092.5 53368.0 1476.1 1481.6 1486.3 1486.8 1492.2 26749.9 26957.9 27093.0 27128.6 27213.0 37653.0 37741.6 37856.6 37972.0 37995.8 189731.0 191237.0 191482.0 191661.0 192216.0 34625.0 35452.5 35937.5 35958.5 36013.6 44303.0 45086.8 45488.1 45498.5 45648.3 32026.4 32269.8 32326.2 32348.5 32829.3 32376.0 32520.8 32555.5 32564.0 32705.0 36658.8 37068.3 37174.8 37198.8 37403.8 31813.8 32002.5 32133.8 32231.8 32499.8 23445.4 23630.2 23890.3 24003.8 24088.0 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#2] jquery.html Cycles:180 Average:33913.02 Median:22561.05 stddev:79474.41 (352.3%) stddev-sans-first:79658.00 04:08:53 INFO - PID 9668 | Values: 599.5 603.4 603.4 608.2 609.4 21800.3 22517.2 22697.8 22715.9 22744.1 22246.2 23913.5 24115.5 24166.3 24297.0 6526.1 6686.0 6716.8 6717.6 6728.8 6282.2 6564.6 6585.2 6596.5 6639.6 6584.0 6612.9 6630.8 6634.0 6641.4 6215.4 6480.3 6491.6 6553.4 6588.1 6015.0 6033.0 6034.2 6053.9 6062.9 28017.7 28177.0 28261.3 28503.9 28615.9 2013.1 2032.5 2040.4 2041.9 2047.4 18027.5 18395.0 18682.5 18841.9 18845.2 2402.5 2451.0 2465.1 2468.7 2516.0 115586.0 123549.0 138244.0 142767.0 143198.3 14737.4 14866.9 14870.5 14903.6 15216.0 23534.0 23664.2 23680.9 23711.3 23754.4 10314.3 10516.8 10532.6 10571.3 10601.1 9639.5 9762.9 9796.6 9798.6 9853.4 9005.7 9131.0 9180.2 9295.3 9373.8 2737.3 2741.6 2784.4 2790.9 2802.0 964.1 971.9 982.3 995.3 996.0 18398.7 18527.9 18653.3 18934.8 19062.6 1026.1 1034.8 1045.7 1054.1 1067.2 10233.3 10378.7 10419.3 10550.3 10577.8 462027.0 464430.2 471460.0 475180.0 480446.0 112830.4 115841.0 117913.0 117987.0 117991.4 1075.3 1167.9 1173.9 1225.1 1227.3 19457.2 19731.7 20047.2 20077.7 20173.6 55662.4 56907.4 56909.4 57501.4 58000.4 67661.7 68344.3 69765.0 70736.6 71681.0 14069.4 14215.4 14253.9 14333.9 14373.7 22001.3 22200.7 22243.2 22604.9 22672.9 17505.9 17982.4 18053.3 18140.9 18154.6 15906.9 16090.9 16259.3 16490.7 16774.3 17727.6 17754.7 17799.1 17805.3 18239.7 14109.9 14127.9 14132.0 14198.0 14212.5 17556.8 17713.4 17713.4 17974.9 18172.5 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#3] mootools.html Cycles:180 Average:9573.83 Median:28182.50 stddev:6956.03 (24.7%) stddev-sans-first:6947.97 04:08:53 INFO - PID 9668 | Values: 1331.4 1421.7 1426.6 1439.7 1445.6 12823.5 13439.3 15577.8 16146.6 16178.7 15475.3 15764.2 15795.3 15797.6 15807.4 2483.5 2815.2 2817.9 2838.3 2877.7 2874.8 2901.3 2902.2 2902.3 2903.2 2332.4 2775.8 2860.2 2862.9 2865.3 2820.2 2848.8 2851.4 2863.9 2867.9 2708.9 2719.0 2735.8 2754.0 2765.5 15134.0 15520.5 15605.7 15623.7 15630.4 7963.6 8195.1 8234.5 8241.8 8272.0 5360.2 5511.3 5590.8 5612.8 5659.4 1924.5 2006.4 2015.8 2051.2 2059.6 26338.7 28181.0 28184.0 28393.3 28478.7 7234.9 7262.5 7356.2 7461.2 7489.7 17964.7 17970.6 17983.9 18008.3 18017.1 7946.9 8091.4 8131.5 8138.1 8159.7 7489.3 7541.2 7642.8 7774.2 7781.6 5391.6 5434.7 5563.5 5601.2 5613.3 1640.7 1656.7 1658.5 1665.8 1681.9 886.7 898.5 907.9 910.0 917.3 7479.6 7526.3 7531.7 7552.4 7592.4 721.1 743.6 748.4 751.5 765.9 4618.3 4974.7 5226.5 5331.1 5356.3 22129.1 22808.2 23117.4 23138.8 23376.6 21408.8 22682.3 22684.4 22718.7 23083.0 9667.7 11784.6 11995.5 12183.3 12195.8 7187.7 9131.0 9152.2 9191.2 9212.7 18082.1 18666.8 18716.8 19494.0 19852.6 19380.6 19819.2 19847.0 19883.1 20033.7 10587.8 10623.9 10713.5 10721.6 10761.6 14175.6 14192.3 14197.2 14232.4 14257.6 10957.3 11069.6 11110.7 11360.2 11523.7 11190.3 11491.5 11506.9 11554.0 11999.5 9631.8 9690.6 9735.7 9737.6 9742.0 7378.6 7412.7 7418.4 7439.4 7483.2 7624.8 7632.1 7640.4 7695.2 7772.0 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#4] prototype.html Cycles:180 Average:5459.48 Median:6135.48 stddev:1510.59 (24.6%) stddev-sans-first:1468.42 04:08:53 INFO - PID 9668 | Values: 508.7 535.8 537.0 538.2 548.5 6108.8 6188.2 6259.4 6261.9 6294.3 6101.2 6105.8 6123.2 6168.9 6205.6 5107.7 5126.4 5169.1 5175.4 5193.5 4836.0 5140.9 5154.0 5157.8 5214.8 4910.5 4944.4 4966.4 4984.8 5008.9 4931.3 4954.6 4955.5 4961.3 5008.4 4462.4 4479.3 4479.3 4499.0 4516.8 6055.9 6080.9 6147.8 6149.0 6161.1 5688.4 5713.5 5733.3 5742.3 5782.2 6438.5 6447.0 6468.1 6492.4 6555.7 4811.9 4837.3 4845.6 4846.7 4867.6 6417.4 6664.7 6675.4 6709.6 6714.9 4939.7 4951.6 4955.4 4979.9 4997.9 5046.9 5058.6 5077.3 5078.1 5108.9 5593.6 5677.5 5686.9 5691.7 5743.2 6465.4 6571.9 6592.7 6596.9 6609.3 1752.4 1763.6 1764.4 1765.4 1768.7 1159.2 1226.8 1229.2 1233.5 1244.5 5521.8 5566.8 5650.7 5655.3 5723.5 6545.5 6553.0 6590.7 6650.2 6653.1 5528.9 5582.8 5670.4 5674.2 5727.3 3430.7 3457.9 3474.3 3480.0 3525.5 6352.8 6376.3 6396.1 6409.6 6477.6 6218.8 6753.5 6764.4 6826.0 6828.7 6261.2 6278.0 6293.3 6392.3 6414.5 6450.4 6512.0 6513.9 6518.9 6584.0 6506.5 6594.8 6661.7 6689.9 6695.9 6389.3 6423.2 6463.4 6470.8 6488.3 4855.9 4922.6 4945.9 5003.1 5005.4 6201.6 6481.8 6533.6 6623.6 6695.9 6460.5 6483.7 6546.8 6551.8 6559.5 6353.6 6381.2 6388.2 6419.3 6428.2 6339.6 6364.6 6376.6 6383.5 6392.8 6416.9 6461.5 6488.9 6520.5 6567.7 6291.5 6314.3 6323.3 6339.8 6411.9 04:08:53 INFO - PID 9668 | 04:08:53 INFO - PID 9668 | [#5] yui.html Cycles:180 Average:24199.83 Median:20128.95 stddev:35202.09 (174.9%) stddev-sans-first:35257.29 04:08:53 INFO - PID 9668 | Values: 881.2 904.8 915.6 924.6 936.9 19753.8 20315.8 20431.1 20437.9 20441.0 18449.2 18659.8 18917.2 18977.5 19070.1 957.4 968.8 968.9 970.4 972.9 934.0 987.9 992.6 992.9 993.9 1029.9 1040.0 1042.7 1043.0 1044.1 1033.5 1033.9 1035.1 1035.5 1039.0 699.1 721.7 725.9 727.0 727.3 19975.2 20112.4 20145.5 20158.8 20190.4 21506.0 21560.2 22638.3 22644.8 22649.7 17694.7 17890.4 18059.0 18185.9 18216.2 3803.7 3810.3 3827.2 3828.4 3840.2 135398.0 136749.0 137386.0 138243.0 138640.0 16459.3 16646.5 16877.2 16974.7 17120.4 31201.2 31622.5 31783.2 31965.8 31991.2 8472.0 8545.4 8550.1 8553.0 8558.5 4335.3 4344.1 4465.8 4512.3 4561.7 5546.7 5710.1 5717.5 5729.4 5743.6 988.8 999.0 1016.9 1023.0 1023.3 697.5 709.9 719.4 720.3 721.4 11244.3 11514.8 11536.9 12515.6 12679.2 665.5 679.4 682.4 694.1 699.9 5100.8 5240.2 5268.8 5329.8 5338.0 122517.0 122954.0 123198.0 123361.0 126052.0 105455.5 108079.5 108205.0 110358.4 110451.0 96057.0 96150.5 96771.0 98653.0 98666.0 10004.5 10117.9 10198.5 10342.9 10357.5 42360.8 42386.2 43252.8 43704.6 43789.8 54444.2 54975.0 55283.0 55788.2 55948.7 15202.7 15561.1 15707.2 15723.0 15736.1 16734.7 16977.7 17135.1 17143.6 17230.8 15129.8 15185.4 15253.5 15312.5 15315.9 14948.4 15069.9 15076.2 15199.0 15256.7 14405.4 14411.3 14654.9 14684.6 14728.3 11322.8 11508.1 11578.0 11667.9 11705.0 10934.3 11038.9 11078.9 11247.3 11537.4 04:08:53 INFO - PID 9668 | -------- Summary: end -------- 04:08:53 INFO - PID 9668 | 04:08:53 INFO - TEST-INFO | 9668: exit 0 04:08:54 INFO - TEST-OK | dromaeo_css | took 1107685ms 04:08:54 INFO - TEST-START | kraken 04:08:54 INFO - Initialising browser for kraken test... 04:08:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37352/getInfo.html -profile /tmp/tmpF2Roo5/profile 04:08:54 INFO - TEST-INFO | started process 10030 (/builds/slave/test/build/application/firefox/firefox http://localhost:37352/getInfo.html) 04:08:59 INFO - TEST-INFO | 10030: exit 0 04:08:59 INFO - Browser initialized. 04:08:59 INFO - Running cycle 1/1 for kraken test... 04:08:59 INFO - Using env: {'DISPLAY': ':0', 04:08:59 INFO - 'HOME': '/home/cltbld', 04:08:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:08:59 INFO - 'LANG': 'en_US.UTF-8', 04:08:59 INFO - 'LANGUAGE': 'en_US:en', 04:08:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:08:59 INFO - 'LOGNAME': 'cltbld', 04:08:59 INFO - 'MAIL': '/var/mail/cltbld', 04:08:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:08:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:08:59 INFO - 'MOZ_NO_REMOTE': '1', 04:08:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:59 INFO - 'NO_EM_RESTART': '1', 04:08:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:59 INFO - 'PWD': '/builds/slave/test', 04:08:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:59 INFO - 'RUST_BACKTRACE': 'full', 04:08:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:08:59 INFO - 'SHELL': '/bin/bash', 04:08:59 INFO - 'SHLVL': '1', 04:08:59 INFO - 'STYLO_FORCE_DISABLED': '1', 04:08:59 INFO - 'TERM': 'linux', 04:08:59 INFO - 'TMOUT': '86400', 04:08:59 INFO - 'USER': 'cltbld', 04:08:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200', 04:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:59 INFO - '_': '/tools/buildbot/bin/python'} 04:08:59 INFO - TEST-INFO | started process 10266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF2Roo5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:00 INFO - PID 10266 | 04:09:00 INFO - PID 10266 | (/builds/slave/test/build/application/firefox/firefox:10315): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:00 INFO - PID 10266 | 04:09:10 INFO - PID 10266 | RSS: Main: 151666688 04:09:10 INFO - PID 10266 | 04:09:13 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:14 INFO - PID 10266 | RSS: Main: 157544448 04:09:14 INFO - PID 10266 | 04:09:16 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-dft) 04:09:17 INFO - PID 10266 | RSS: Main: 157937664 04:09:17 INFO - PID 10266 | 04:09:20 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-fft) 04:09:20 INFO - PID 10266 | RSS: Main: 154595328 04:09:20 INFO - PID 10266 | 04:09:23 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37352/tests/kraken/driver.html?testName=audio-oscillator) 04:09:23 INFO - PID 10266 | RSS: Main: 155189248 04:09:23 INFO - PID 10266 | 04:09:25 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:26 INFO - PID 10266 | RSS: Main: 155623424 04:09:26 INFO - PID 10266 | 04:09:29 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:30 INFO - PID 10266 | RSS: Main: 157741056 04:09:30 INFO - PID 10266 | 04:09:33 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37352/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:34 INFO - PID 10266 | RSS: Main: 158035968 04:09:34 INFO - PID 10266 | 04:09:37 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37352/tests/kraken/driver.html?testName=json-parse-financial) 04:09:38 INFO - PID 10266 | RSS: Main: 158199808 04:09:38 INFO - PID 10266 | 04:09:39 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:40 INFO - PID 10266 | RSS: Main: 157777920 04:09:40 INFO - PID 10266 | 04:09:41 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:42 INFO - PID 10266 | RSS: Main: 157769728 04:09:42 INFO - PID 10266 | 04:09:44 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:45 INFO - PID 10266 | RSS: Main: 155090944 04:09:45 INFO - PID 10266 | 04:09:47 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:48 INFO - PID 10266 | RSS: Main: 155463680 04:09:48 INFO - PID 10266 | 04:09:51 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:52 INFO - PID 10266 | RSS: Main: 155402240 04:09:52 INFO - PID 10266 | 04:09:53 INFO - PID 10266 | Cycle 1(1): loaded http://localhost:37352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37352/tests/kraken/driver.html?testName=ai-astar) 04:09:54 INFO - PID 10266 | RSS: Main: 156680192 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | __start_tp_report 04:09:54 INFO - PID 10266 | _x_x_mozilla_page_load 04:09:54 INFO - PID 10266 | _x_x_mozilla_page_load_details 04:09:54 INFO - PID 10266 | |i|pagename|runs| 04:09:54 INFO - PID 10266 | |0;ai-astar;108;108;109;108;107;102;106;107;108;107 04:09:54 INFO - PID 10266 | |1;audio-beat-detection;117;119;117;117;119;121;120;127;141;116 04:09:54 INFO - PID 10266 | |2;audio-dft;164;164;164;163;164;163;163;165;168;168 04:09:54 INFO - PID 10266 | |3;audio-fft;75;74;74;74;73;75;77;74;76;73 04:09:54 INFO - PID 10266 | |4;audio-oscillator;81;80;80;79;79;79;78;79;79;80 04:09:54 INFO - PID 10266 | |5;imaging-gaussian-blur;113;114;117;114;114;114;115;114;115;114 04:09:54 INFO - PID 10266 | |6;imaging-darkroom;148;149;149;148;150;149;149;150;149;149 04:09:54 INFO - PID 10266 | |7;imaging-desaturate;95;95;99;95;95;95;95;95;95;95 04:09:54 INFO - PID 10266 | |8;json-parse-financial;54;55;57;53;55;53;55;55;63;54 04:09:54 INFO - PID 10266 | |9;json-stringify-tinderbox;38;39;38;41;38;38;38;38;39;38 04:09:54 INFO - PID 10266 | |10;stanford-crypto-aes;74;72;73;77;74;78;79;75;75;73 04:09:54 INFO - PID 10266 | |11;stanford-crypto-ccm;112;115;108;121;115;112;114;112;117;116 04:09:54 INFO - PID 10266 | |12;stanford-crypto-pbkdf2;173;176;167;173;167;175;163;166;167;166 04:09:54 INFO - PID 10266 | |13;stanford-crypto-sha256-iterative;69;68;72;68;67;67;65;65;65;72 04:09:54 INFO - PID 10266 | __end_tp_report 04:09:54 INFO - PID 10266 | __start_cc_report 04:09:54 INFO - PID 10266 | _x_x_mozilla_cycle_collect,743 04:09:54 INFO - PID 10266 | __end_cc_report 04:09:54 INFO - PID 10266 | __startTimestamp1506337794084__endTimestamp 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | ------- Summary: start ------- 04:09:54 INFO - PID 10266 | Number of tests: 14 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.00 stddev:1.94 (1.8%) stddev-sans-first:2.03 04:09:54 INFO - PID 10266 | Values: 108.0 108.0 109.0 108.0 107.0 102.0 106.0 107.0 108.0 107.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:119.50 stddev:7.57 (6.3%) stddev-sans-first:7.87 04:09:54 INFO - PID 10266 | Values: 117.0 119.0 117.0 117.0 119.0 121.0 120.0 127.0 141.0 116.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 04:09:54 INFO - PID 10266 | Values: 164.0 164.0 164.0 163.0 164.0 163.0 163.0 165.0 168.0 168.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.50 stddev:1.27 (1.7%) stddev-sans-first:1.33 04:09:54 INFO - PID 10266 | Values: 75.0 74.0 74.0 74.0 73.0 75.0 77.0 74.0 76.0 73.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.67 04:09:54 INFO - PID 10266 | Values: 81.0 80.0 80.0 79.0 79.0 79.0 78.0 79.0 79.0 80.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.01 04:09:54 INFO - PID 10266 | Values: 113.0 114.0 117.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 04:09:54 INFO - PID 10266 | Values: 148.0 149.0 149.0 148.0 150.0 149.0 149.0 150.0 149.0 149.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 04:09:54 INFO - PID 10266 | Values: 95.0 95.0 99.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.91 (5.3%) stddev-sans-first:3.05 04:09:54 INFO - PID 10266 | Values: 54.0 55.0 57.0 53.0 55.0 53.0 55.0 55.0 63.0 54.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:38.00 stddev:0.97 (2.6%) stddev-sans-first:1.01 04:09:54 INFO - PID 10266 | Values: 38.0 39.0 38.0 41.0 38.0 38.0 38.0 38.0 39.0 38.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.31 (3.1%) stddev-sans-first:2.42 04:09:54 INFO - PID 10266 | Values: 74.0 72.0 73.0 77.0 74.0 78.0 79.0 75.0 75.0 73.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.00 stddev:3.52 (3.1%) stddev-sans-first:3.64 04:09:54 INFO - PID 10266 | Values: 112.0 115.0 108.0 121.0 115.0 112.0 114.0 112.0 117.0 116.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:4.50 (2.6%) stddev-sans-first:4.57 04:09:54 INFO - PID 10266 | Values: 173.0 176.0 167.0 173.0 167.0 175.0 163.0 166.0 167.0 166.0 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:2.62 (3.8%) stddev-sans-first:2.74 04:09:54 INFO - PID 10266 | Values: 69.0 68.0 72.0 68.0 67.0 67.0 65.0 65.0 65.0 72.0 04:09:54 INFO - PID 10266 | -------- Summary: end -------- 04:09:54 INFO - PID 10266 | 04:09:54 INFO - PID 10266 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:09:54 INFO - TEST-INFO | 10266: exit 0 04:09:54 INFO - TEST-OK | kraken | took 60726ms 04:09:54 INFO - SUITE-END | took 1168s 04:09:54 INFO - Completed test suite (00:19:28) 04:09:54 INFO - javascript benchmark 04:09:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8534.779232492661, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.140311414361, 3128.9061328160155, 3170.5878235829337, 3183.1087295557254, 3191.5053166759144, 6163.660998645073, 6318.905216421757, 6338.936610633892, 6371.681415929203, 6452.516061295404, 6286.277078136016, 6309.400606942345, 6317.968410157954, 6325.146105275787, 6351.269603995542, 5754.65472071675, 5794.884102317951, 5907.822765317026, 5911.201987731644, 5920.91118633222, 5736.996025695507, 5933.6439813611105, 5937.346891841894, 6038.939610603904, 6047.848803779897, 5727.856803579923, 5781.103928891008, 5858.033424484955, 5910.202122713422, 5931.139984702194, 5848.532117430638, 5858.091995740667, 5922.0, 5954.136650185742, 5956.761729530814, 5656.604037717361, 5753.88492230153, 5762.135679648044, 5770.336411312669, 5894.823155305347, 6164.0, 6324.177856878622, 6331.240251169889, 6385.361463853624, 6387.233531976192, 6829.658517074176, 6852.45180385573, 6855.862882742367, 6857.759978400732, 6861.725530978755, 6807.489438292098, 6816.454683625348, 6832.624205668686, 6887.827804304882, 6909.447244220501, 6250.0, 6302.842428939267, 6345.270293916166, 6350.777722779727, 6417.294097649255, 6981.89527157093, 7013.964930175316, 7040.788776336718, 7065.752698655522, 7072.540284881569, 6656.73373065072, 6671.266160722316, 6728.865422691617, 6732.831679208059, 6766.627835469097, 6796.932030679729, 6828.146481689789, 6857.828554286083, 6887.414569761627, 6911.136107986502, 6476.093346931433, 6556.508261880378, 6570.967145164243, 6581.3418658133805, 6584.473242140617, 6718.49611279156, 6762.830929226809, 6838.48711346651, 6849.109615750021, 6850.143732033496, 5229.372475302912, 5277.393099793573, 5316.9202461963105, 5317.973410133002, 5320.388155362106, 4620.283856002325, 4626.236670949255, 4643.930341044887, 4671.18254305502, 4717.985633088902, 5729.197912292282, 5823.56323275756, 5850.707464626752, 5904.645721256738, 5911.349751527328, 6765.729370825112, 6805.217399999064, 6877.277885821916, 6883.036374907517, 6885.758998435031, 5830.0, 5869.266341707286, 5898.970505147533, 5924.496417804535, 5930.28836539618, 5799.768009279582, 5810.389909059572, 5875.030619947661, 5883.0, 5897.823065308047, 6245.0632405139595, 6578.0, 6587.0, 6650.567713098633, 6660.167479065117, 6741.932580674229, 6750.594964302158, 6765.255821859493, 6846.7945961621235, 6851.0, 6540.967295163494, 6603.603783772989, 6618.106555614931, 6623.834404139935, 6623.867522649423, 6704.4301234395625, 6787.0, 6807.727690892309, 6812.352826481477, 6812.965935170292, 6811.761588344384, 6813.659317034029, 6907.585544867324, 6916.377526022682, 6929.099217101744, 6426.4216220540375, 6532.738690452328, 6547.639879806657, 6547.803565893031, 6568.868622627616, 6538.673066346759, 6603.0, 6603.372679595431, 6694.83262918431, 6705.430038446591, 6502.187226596676, 6561.934380656323, 6564.310747371648, 6569.507286953402, 6573.112629795108, 6617.470602351897, 6629.7348106075215, 6660.367265109807, 6662.933370666426, 6749.628770417477, 6272.717727702356, 6378.48972082223, 6413.1021656969, 6496.675166241764, 6497.837554061186], "value": 6190.0887664445545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.4775486952962, 887.2635712358741, 912.4844462878469, 914.2046419614932, 920.3235621817963, 39578.60421395785, 41951.370729439004, 42069.36895946563, 42228.78885605572, 42389.36415953763, 39175.60824391755, 39290.21419571607, 39535.209295814064, 39541.0, 39576.80211598945, 7233.819154521127, 7360.484766066377, 7365.410767138616, 7373.926260737405, 7384.409247260206, 7240.746573869916, 7314.743983960562, 7315.231900650435, 7317.121945366537, 7400.222976587462, 7284.380827629658, 7337.0461839961, 7370.705171793122, 7374.410047196211, 7857.371410287164, 7961.681532738684, 8028.317593004544, 8030.9196908031045, 8033.1163572007035, 8039.276465118168, 7841.725539606144, 7941.5632140232265, 7945.205479452008, 7945.562994035326, 7949.284564389175, 38919.805400972815, 39196.0, 39355.606443935765, 40115.59884401148, 40126.79936600327, 3591.3356029134434, 3634.509341238952, 3640.21735326906, 3641.563012438498, 3641.5630124385243, 32465.35069298601, 32771.50842737361, 32791.344173116406, 32792.0, 32795.34409311824, 5113.079645663779, 5147.330846989905, 5153.948460515385, 5191.844244672666, 5252.763625636855, 188104.0, 189312.0, 189424.0, 189624.0518797411, 190254.0, 50576.0, 50593.24110138351, 50598.24102638463, 50619.49380506148, 50654.49345506498, 51793.7410312946, 52068.479315206365, 52331.0, 52362.73818630882, 52381.7380913093, 15239.466618668293, 15597.064176149468, 15609.60975975587, 15643.374265029499, 15647.374105035671, 12391.194572352768, 12443.066769992287, 12480.750384992249, 12485.126041177213, 12523.123381363217, 14127.929360353133, 14198.148111113367, 14289.927960445677, 14334.068285561405, 14425.42298308056, 5750.741216645261, 5804.6807425592, 5859.150423188614, 5903.675297858573, 5936.287645482484, 999.9950000249952, 1003.5634498992962, 1018.312638968708, 1021.4790456867051, 1028.0798685176726, 23149.652755208685, 23238.070477181063, 23361.934282704904, 23381.0, 23601.40996475102, 1111.2776695148218, 1112.4993752811267, 1127.7293449572044, 1128.9774204515863, 1129.6554550862065, 12343.629691109281, 12432.191907525981, 12447.0, 12543.24740515572, 12548.686282843002, 223647.0, 223741.0, 224651.0, 224775.0, 225140.0, 46061.0, 46647.76676116598, 51831.22253166205, 53092.46907530953, 53368.0, 1476.1290838405391, 1481.64440534271, 1486.2568715642394, 1486.762118061105, 1492.1942151238427, 26749.866250668623, 26957.865210673823, 27093.0, 27128.593071103554, 27213.0, 37653.0, 37741.62258377381, 37856.62143378531, 37972.0, 37995.81002094972, 189731.0, 191237.0, 191482.0, 191661.0, 192216.0, 34625.0, 35452.46821297734, 35937.46093808542, 35958.46062309015, 36013.639863602075, 44303.0, 45086.77456612696, 45488.09023819571, 45498.54501454943, 45648.31527527023, 32026.35947280995, 32269.838650806596, 32326.19184520406, 32348.514772277966, 32829.34341313112, 32376.0, 32520.83739581287, 32555.511667324536, 32564.0, 32705.0, 36658.8167059163, 37068.25863482769, 37174.814125929195, 37198.814005929795, 37403.81298093492, 31813.840930796123, 32002.51996220012, 32133.839330803195, 32231.838840805645, 32499.837500812344, 23445.41386465352, 23630.17294394688, 23890.283291501284, 24003.759962400152, 24088.036478540664], "value": 17318.229414157406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4904331318377, 603.4177019176495, 603.4327731931986, 608.1880689279811, 609.3997412548641, 21800.345989620317, 22517.211897583587, 22697.773022269794, 22715.864206789676, 22744.090236390526, 22246.221382251624, 23913.521729565397, 24115.517689646196, 24166.275011749676, 24297.028118875267, 6526.053722210277, 6686.0, 6716.832079198035, 6717.63053032083, 6728.764493242737, 6282.183316168892, 6564.638944858031, 6585.209774827027, 6596.505262105337, 6639.5684280521855, 6583.967080164616, 6612.867742645144, 6630.767923122692, 6634.038064480672, 6641.435477984377, 6215.378462153816, 6480.287168411471, 6491.610503369766, 6553.377429144223, 6588.143541339619, 6015.0375939849855, 6033.034714445667, 6034.185384973016, 6053.878922421527, 6062.878742425127, 28017.71982280192, 28177.0, 28261.293467663472, 28503.85748071267, 28615.856920715472, 2013.1242909334487, 2032.4715573950732, 2040.3776848061336, 2041.9183232670675, 2047.4267205182573, 18027.459176224733, 18395.0, 18682.532936676555, 18841.90579047096, 18845.151968161466, 2402.519496100769, 2450.9950920122665, 2465.0509553821908, 2468.691413573303, 2515.9874200629065, 115586.0, 123549.0, 138244.0, 142767.0, 143198.2840085793, 14737.410503579951, 14866.851331486763, 14870.479533216501, 14903.584159505046, 15216.01095928761, 23534.0, 23664.17175398853, 23680.881595591913, 23711.288661340186, 23754.406139846644, 10314.27800053989, 10516.789664206826, 10532.578696852193, 10571.312864663772, 10601.098906593026, 9639.518024098767, 9762.90237097634, 9796.608135674636, 9798.559064842098, 9853.40879547215, 9005.684801031932, 9131.0, 9180.21968132703, 9295.349325547282, 9373.812523749486, 2737.2609395463114, 2741.5613501840007, 2784.443111377692, 2790.944181116407, 2801.9859900700367, 964.1178321835582, 971.9319647624599, 982.3320142303303, 995.3032876986139, 995.9751006224758, 18398.724019139725, 18527.90736046338, 18653.347132850286, 18934.810651893582, 19062.61874762525, 1026.0662796854826, 1034.8085604163255, 1045.7072019834459, 1054.1145437832258, 1067.2315932528568, 10233.283670143168, 10378.688639340831, 10419.322744021614, 10550.261481696361, 10577.788444231071, 462027.0, 464430.2145974258, 471460.0, 475180.0, 480446.0, 112830.43584782023, 115841.0, 117913.0, 117987.0, 117991.41004294924, 1075.2526993739275, 1167.8890505401973, 1173.906087512997, 1225.1424003197797, 1227.2759072147476, 19457.221711131395, 19731.704024439357, 20047.198112075355, 20077.698834517785, 20173.59652806965, 55662.443375567345, 56907.43092569021, 56909.43090569207, 57501.4249857496, 58000.4199957995, 67661.66169169123, 68344.3165568338, 69765.0, 70736.64631676809, 71681.0, 14069.366878490287, 14215.360308785923, 14253.928730356281, 14333.928330358282, 14373.712525749635, 22001.339959801233, 22200.666989995487, 22243.22148724787, 22604.886975565016, 22672.886635566716, 17505.912470437564, 17982.37061702834, 18053.277868885096, 18140.90929545344, 18154.636907262044, 15906.9204653976, 16090.873638845169, 16259.268332925283, 16490.670186596442, 16774.32902683879, 17727.645447091243, 17754.733678994566, 17799.110044497982, 17805.306554333307, 18239.726404104214, 14109.929450352682, 14127.858721412655, 14132.0, 14198.00613957013, 14212.502562410265, 17556.82443175603, 17713.380031698827, 17713.380031699344, 17974.91012544929, 18172.545686357946], "value": 11888.157444537967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3609467455622, 1421.7440860645079, 1426.6433391652083, 1439.654482924098, 1445.551878917535, 12823.48706051758, 13439.260840653773, 15577.766333505006, 16146.596335091599, 16178.676426471464, 15475.30361133749, 15764.211789410541, 15795.289211985459, 15797.60505987351, 15807.446739364124, 2483.4908843687, 2815.197668664431, 2817.929551761212, 2838.3329917469378, 2877.6690680571687, 2874.755645770112, 2901.3036871150875, 2902.2018944790248, 2902.2599237194486, 2903.187107609862, 2332.4052366646565, 2775.8056936014486, 2860.199144239616, 2862.8711707973193, 2865.298001989505, 2820.1539538138477, 2848.7720982321366, 2851.4012057467958, 2863.871125799344, 2867.9283017924613, 2708.891644334224, 2718.972810271892, 2735.8084934054623, 2754.0223220756743, 2765.5298599238176, 15134.016288941293, 15520.5343839685, 15605.687886242325, 15623.687526249412, 15630.374785008586, 7963.601819908981, 8195.098539160688, 8234.547099909563, 8241.83516329676, 8272.0, 5360.2227676987, 5511.285224591556, 5590.8043218487155, 5612.803551875665, 5659.4340565943485, 1924.5092501412191, 2006.3579654510563, 2015.8185763281374, 2051.1590247998397, 2059.588082383529, 26338.736612633627, 28181.0, 28184.0, 28393.290167745767, 28478.715212847812, 7234.927650723531, 7262.5111852070195, 7356.204642235916, 7461.246607047339, 7489.737859174903, 17964.730529042074, 17970.640587188445, 17983.910080449514, 18008.279668813364, 18017.099145042695, 7946.920530794734, 8091.393145513992, 8131.5363234618335, 8138.145494723087, 8159.714409995621, 7489.28851759082, 7541.2458754124145, 7642.8089297768, 7774.1837107104075, 7781.572013539309, 5391.595630327663, 5434.728263586805, 5563.499285064364, 5601.215829783833, 5613.326400831927, 1640.7456844189169, 1656.7017936771497, 1658.5107393319, 1665.808432030332, 1681.9327226910787, 886.6586364249811, 898.5237823953315, 907.9319051071196, 909.9681511147078, 917.3211823250747, 7479.551226926402, 7526.32263096324, 7531.661075251627, 7552.39580833543, 7592.354649854714, 721.1166321256419, 743.598456833304, 748.4498893313411, 751.4814777803298, 765.9004329437138, 4618.30725391194, 4974.676646017997, 5226.477352264819, 5331.1470164773455, 5356.330458692663, 22129.114835406726, 22808.20171293997, 23117.422064448187, 23138.768612313663, 23376.64935025976, 21408.78591214099, 22682.319530413784, 22684.432889177904, 22718.659220111713, 23083.0, 9667.661631842851, 11784.646460606196, 11995.520179192734, 12183.329916854658, 12195.756084878252, 7187.676554554953, 9131.0, 9152.17630413266, 9191.21874640663, 9212.723618291462, 18082.095895204922, 18666.813331866506, 18716.812831871506, 19493.999999999432, 19852.60294794125, 19380.612387752448, 19819.20723171057, 19847.0, 19883.105260263033, 20033.699494507884, 10587.788244235226, 10623.89376106229, 10713.517891694737, 10721.624743133953, 10761.569537218424, 14175.574732758034, 14192.290385480479, 14197.219152946687, 14232.430702771773, 14257.64355891111, 10957.287776294515, 11069.612563560559, 11110.666679999613, 11360.204785664924, 11523.654290371302, 11190.32858028521, 11491.482883270106, 11506.94246528762, 11554.0, 11999.460024298753, 9631.759206019906, 9690.612375504901, 9735.70792876215, 9737.561809718722, 9742.0, 7378.5941773202985, 7412.740554080581, 7418.443616728875, 7439.442041846992, 7483.176850546544, 7624.771256862303, 7632.122305934889, 7640.426967977312, 7695.23047695226, 7771.961140194263], "value": 6799.357285130507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.70826924704227, 535.8238666127849, 536.9838904832854, 538.1631562919661, 548.5145646103202, 6108.816735497942, 6188.195534580509, 6259.405356491132, 6261.937380626192, 6294.339094395085, 6101.230643113492, 6105.786297479589, 6123.173371594833, 6168.876622467548, 6205.596636218643, 5107.693538387709, 5126.384833819928, 5169.121249387595, 5175.353080864892, 5193.5325820676135, 4835.951640483585, 5140.871478213037, 5153.974230128844, 5157.7936882524655, 5214.843554693346, 4910.533499317559, 4944.381952255968, 4966.428860681014, 4984.825531106412, 5008.874778130557, 4931.284963680282, 4954.578860796837, 4955.529224723646, 4961.305417241589, 5008.449070602231, 4462.419885414875, 4479.283314669669, 4479.305707615293, 4498.955010449887, 4516.774161291923, 6055.909161362583, 6080.939190608082, 6147.784827531015, 6148.96925515374, 6161.075838624198, 5688.4311568843195, 5713.485786279255, 5733.283339582552, 5742.253507044057, 5782.161586569966, 6438.549301548894, 6447.0, 6468.1268028815975, 6492.350764923517, 6555.737770489175, 4811.927821082687, 4837.346958160639, 4845.563899249085, 4846.709197448165, 4867.586255168279, 6417.422431981144, 6664.700088496029, 6675.432588230006, 6709.597424154566, 6714.89204281293, 4939.678920870132, 4951.628627852925, 4955.380577427822, 4979.850604481871, 4997.85006449807, 5046.873828154326, 5058.570021548209, 5077.263796749525, 5078.0703332734065, 5108.923366149511, 5593.636413633101, 5677.489025987681, 5686.857828554319, 5691.658500489983, 5743.195952566644, 6465.418112369909, 6571.868562628816, 6592.670366481752, 6596.944488881852, 6609.306022867626, 1752.3516298969207, 1763.5943732941496, 1764.3560100563202, 1765.382116259299, 1768.7081631530652, 1159.1943599198644, 1226.8405107335989, 1229.2317301686446, 1233.463443402123, 1244.5270797097046, 5521.806736764274, 5566.775309431919, 5650.7174641267775, 5655.349634791969, 5723.540497173194, 6545.541812073205, 6553.017047442826, 6590.703418346186, 6650.235222949326, 6653.1018312527185, 5528.889422211614, 5582.8325150245555, 5670.376258611632, 5674.2339784129435, 5727.284089488814, 3430.6740859618294, 3457.856129199912, 3474.2877710069374, 3479.9652003480146, 3525.5016617937786, 6352.8411789704705, 6376.29860715321, 6396.0725694774, 6409.615423074631, 6477.611343319416, 6218.844528886723, 6753.493487988322, 6764.3573860483175, 6826.0, 6828.692708828015, 6261.248650161919, 6277.968610157011, 6293.3391993840905, 6392.274085996755, 6414.454771344488, 6450.41946224842, 6512.0, 6513.934860651333, 6518.924377477663, 6583.967080164569, 6506.512011599054, 6594.769183078569, 6661.666916654051, 6689.929611262175, 6695.866082678222, 6389.265234497906, 6423.229212494531, 6463.385978332051, 6470.838229044311, 6488.253850807028, 4855.854324370274, 4922.556969872729, 4945.91189938213, 5003.149464590955, 5005.374328208974, 6201.627902325875, 6481.837954051187, 6533.640649764308, 6623.635700036544, 6695.899561506679, 6460.4508616766225, 6483.675816209265, 6546.770863019771, 6551.80344589663, 6559.508036897348, 6353.618782873043, 6381.202349706286, 6388.169537960035, 6419.2938776735455, 6428.164338636135, 6339.5562310637815, 6364.6181229126405, 6376.585521941059, 6383.521235907233, 6392.808215753535, 6416.935830641821, 6461.547691661539, 6488.902666459912, 6520.543561950618, 6567.704453299518, 6291.496680265476, 6314.336994615683, 6323.272823625158, 6339.7954388666, 6411.871762564816], "value": 5020.370568510285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.2465342132481, 904.7964208053187, 915.5925613102168, 924.6162842420391, 936.9484678342691, 19753.802461975374, 20315.796842031574, 20431.080601372938, 20437.897810510927, 20440.977951102443, 18449.169787359566, 18659.813401865977, 18917.243310267608, 18977.52556186096, 19070.141843617035, 957.4207604399326, 968.7529679931642, 968.8643589897384, 970.4177493503912, 972.8735264415616, 933.9626414943428, 987.866638003871, 992.6376872441543, 992.925530585209, 993.9006099390075, 1029.8712660917386, 1039.9844002339971, 1042.6976176908724, 1043.0143514378915, 1044.0551301072542, 1033.4987531047436, 1033.89144139865, 1035.073609119841, 1035.5340096956363, 1039.049269918028, 699.1121275979477, 721.7041013184569, 725.8947452619393, 726.985854732645, 727.2727272727273, 19975.200991960304, 20112.39662810118, 20145.496362590908, 20158.79841201584, 20190.394288171377, 21506.0, 21560.245391411383, 22638.320850374515, 22644.773552264596, 22649.660255096187, 17694.734578981326, 17890.373836915776, 18059.0, 18185.909070454694, 18216.180271887795, 3803.7337386382965, 3810.333191691471, 3827.158025234444, 3828.4257361395735, 3840.1551658635058, 135398.0, 136749.0, 137386.0, 138243.0, 138640.0, 16459.25933333003, 16646.50060498187, 16877.240524176443, 16974.660506790042, 17120.40078597243, 31201.219969500944, 31622.525662115087, 31783.205419864225, 31965.840170798998, 31991.20021999422, 8472.02571704262, 8545.401821872409, 8550.059493455716, 8553.0, 8558.529280889486, 4335.284678028153, 4344.066025804467, 4465.843695470708, 4512.300593408027, 4561.7262964222255, 5546.69493177871, 5710.114932185518, 5717.514011309002, 5729.427057294321, 5743.569232307594, 988.7528117970508, 998.9511013435863, 1016.9440680762481, 1022.974425639365, 1023.2581378500528, 697.490831692867, 709.9396551293095, 719.3993015831735, 720.330093013492, 721.3976329764705, 11244.26912250701, 11514.827277590843, 11536.94231528837, 12515.624531264077, 12679.23924564529, 665.5341261117237, 679.4157024958532, 682.3858527325447, 694.1427337238506, 699.9370056694922, 5100.795968161232, 5240.187770895517, 5268.841934741964, 5329.760160792774, 5337.973310133424, 122517.0, 122954.0, 123198.0, 123361.0, 126052.0, 105455.4727226359, 108079.45960270305, 108205.0, 110358.44820775845, 110451.0, 96057.0, 96150.51924740331, 96771.0, 98653.0, 98666.0, 10004.499775011365, 10117.949410253195, 10198.490075496344, 10342.896571034193, 10357.482125893826, 42360.78819605882, 42386.152276954905, 43252.78373608112, 43704.56295437132, 43789.78105109454, 54444.18333724918, 54975.0, 55283.0, 55788.16317755318, 55948.72025639846, 15202.695946081238, 15561.066336019874, 15707.214639268219, 15723.0, 15736.134512601917, 16734.665306693554, 16977.66044679124, 17135.05757183367, 17143.57141071483, 17230.827691722923, 15129.773053404428, 15185.392584296504, 15253.542393728207, 15312.540623780858, 15315.923420382827, 14948.402063917756, 15069.924650376677, 15076.246187690791, 15199.0, 15256.694866102394, 14405.351759170653, 14411.279436028366, 14654.926725366306, 14684.632884177554, 14728.337224824694, 11322.773544528898, 11508.079353651856, 11578.0, 11667.941660291644, 11705.0, 10934.343939363664, 11038.944805275922, 11078.944605277244, 11247.268927519684, 11537.423128843691], "value": 8884.019118854323, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 109.0, 108.0, 107.0, 102.0, 106.0, 107.0, 108.0, 107.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 119.0, 121.0, 120.0, 127.0, 141.0, 116.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 164.0, 163.0, 163.0, 165.0, 168.0, 168.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 74.0, 73.0, 75.0, 77.0, 74.0, 76.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 150.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 53.0, 55.0, 53.0, 55.0, 55.0, 63.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 41.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 77.0, 74.0, 78.0, 79.0, 75.0, 75.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 108.0, 121.0, 115.0, 112.0, 114.0, 112.0, 117.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 167.0, 173.0, 167.0, 175.0, 163.0, 166.0, 167.0, 166.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 68.0, 67.0, 67.0, 65.0, 65.0, 65.0, 72.0], "value": 67.8, "unit": "score"}]}]} 04:09:54 INFO - Return code: 0 04:09:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:09:54 INFO - # TBPL SUCCESS # 04:09:54 INFO - Running post-action listener: _package_coverage_data 04:09:54 INFO - Running post-action listener: _resource_record_post_action 04:09:54 INFO - [mozharness: 2017-09-25 11:09:54.851470Z] Finished run-tests step (success) 04:09:54 INFO - Running post-run listener: _resource_record_post_run 04:09:54 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513519616; Read time: 8; Write time: 358668 04:09:54 INFO - TinderboxPrint: CPU usage
13.1% 04:09:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:09:54 INFO - TinderboxPrint: I/O write bytes / time
513,519,616 / 358,668 04:09:54 INFO - TinderboxPrint: CPU idle
8,221.1 (86.9%) 04:09:54 INFO - TinderboxPrint: CPU user
1,191.7 (12.6%) 04:09:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:09:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 180998144; Read time: 0; Write time: 151076 04:09:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:09:54 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 332521472; Read time: 0; Write time: 207592 04:09:55 INFO - Running post-run listener: _upload_blobber_files 04:09:55 INFO - Blob upload gear active. 04:09:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:09:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:56 INFO - (blobuploader) - INFO - Done attempting. 04:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:00 INFO - (blobuploader) - INFO - Done attempting. 04:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:01 INFO - (blobuploader) - INFO - Done attempting. 04:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:02 INFO - (blobuploader) - INFO - Done attempting. 04:10:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:02 INFO - Return code: 0 04:10:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b558594acb77120e8b75e3acfff0256bdd73c64c43a10583c19936f0790e30e99ec1f5d38fcdd26b3f7675391b2f650f8fd5b5b2af18265020ad9231e5ada10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd57d307d42875cbbc520a8c619355bbd375d0cfe24b7c580cf74b36b9c71837cede4918363754c43f8d4ca7d80eea41c0254f85e32226190f649698a344440", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/667714dd1a306f48fc2da96311a3ee7a10bf36fc79608c35d10d6ab7404a1257bc410f0fa743dbde61cc343d145323164659314a58c03ac715b75c0191c12953", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e57fd029a1854f3958bd48c41b0a942ef3bc495e6fbc36c4af1e3bc31f828b38161e41f6332c188a8e50d7e91ef21006f8394b992fb6fb1c1ded1c9f9978b6fe"} 04:10:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:02 INFO - Contents: 04:10:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b558594acb77120e8b75e3acfff0256bdd73c64c43a10583c19936f0790e30e99ec1f5d38fcdd26b3f7675391b2f650f8fd5b5b2af18265020ad9231e5ada10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd57d307d42875cbbc520a8c619355bbd375d0cfe24b7c580cf74b36b9c71837cede4918363754c43f8d4ca7d80eea41c0254f85e32226190f649698a344440", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/667714dd1a306f48fc2da96311a3ee7a10bf36fc79608c35d10d6ab7404a1257bc410f0fa743dbde61cc343d145323164659314a58c03ac715b75c0191c12953", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e57fd029a1854f3958bd48c41b0a942ef3bc495e6fbc36c4af1e3bc31f828b38161e41f6332c188a8e50d7e91ef21006f8394b992fb6fb1c1ded1c9f9978b6fe"} 04:10:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:02 INFO - Copying logs to upload dir... 04:10:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.940663 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-25 04:10:02.311257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:02.314516) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b558594acb77120e8b75e3acfff0256bdd73c64c43a10583c19936f0790e30e99ec1f5d38fcdd26b3f7675391b2f650f8fd5b5b2af18265020ad9231e5ada10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd57d307d42875cbbc520a8c619355bbd375d0cfe24b7c580cf74b36b9c71837cede4918363754c43f8d4ca7d80eea41c0254f85e32226190f649698a344440", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/667714dd1a306f48fc2da96311a3ee7a10bf36fc79608c35d10d6ab7404a1257bc410f0fa743dbde61cc343d145323164659314a58c03ac715b75c0191c12953", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e57fd029a1854f3958bd48c41b0a942ef3bc495e6fbc36c4af1e3bc31f828b38161e41f6332c188a8e50d7e91ef21006f8394b992fb6fb1c1ded1c9f9978b6fe"} build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011843 build_url: 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b558594acb77120e8b75e3acfff0256bdd73c64c43a10583c19936f0790e30e99ec1f5d38fcdd26b3f7675391b2f650f8fd5b5b2af18265020ad9231e5ada10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd57d307d42875cbbc520a8c619355bbd375d0cfe24b7c580cf74b36b9c71837cede4918363754c43f8d4ca7d80eea41c0254f85e32226190f649698a344440", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/667714dd1a306f48fc2da96311a3ee7a10bf36fc79608c35d10d6ab7404a1257bc410f0fa743dbde61cc343d145323164659314a58c03ac715b75c0191c12953", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e57fd029a1854f3958bd48c41b0a942ef3bc495e6fbc36c4af1e3bc31f828b38161e41f6332c188a8e50d7e91ef21006f8394b992fb6fb1c1ded1c9f9978b6fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:02.344344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:02.344668) ========= 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=3a3620fb28aea1604ab609ef000001d2-1506335009.116513-1246292200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:10:02.428140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:10:02.428451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:10:02.428775) ========= ========= Total master_lag: 0.19 =========