builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-013 starttime: 1506423925.49 results: success (0) revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.486016) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.486420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.486703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.549874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.553158) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 04:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.0M=0s 2017-09-26 04:05:26 (61.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.367999 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.947122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:25.947438) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020316 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.000008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.000373) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fb1f5fae37168c824b988733aac0d46499b6c11 --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 6fb1f5fae37168c824b988733aac0d46499b6c11 --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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 04:05:26,864 truncating revision to first 12 chars 2017-09-26 04:05:26,864 Setting DEBUG logging. 2017-09-26 04:05:26,864 attempt 1/10 2017-09-26 04:05:26,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fb1f5fae371?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 04:05:27,114 unpacking tar archive at: mozilla-central-6fb1f5fae371/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.584570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.584840) ========= script_repo_revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.586227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.586514) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:26.600073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-26 04:05:26.600347) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:27 INFO - MultiFileLogger online at 20170926 04:05:27 in /builds/slave/test 04:05:27 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 04:05:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:27 INFO - {'append_to_log': False, 04:05:27 INFO - 'base_work_dir': '/builds/slave/test', 04:05:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:05:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:27 INFO - 'branch': 'Firefox-Non-PGO', 04:05:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:27 INFO - 'code_coverage': False, 04:05:27 INFO - 'config_files': ('talos/linux_config.py',), 04:05:27 INFO - 'default_actions': ('clobber', 04:05:27 INFO - 'read-buildbot-config', 04:05:27 INFO - 'download-and-extract', 04:05:27 INFO - 'populate-webroot', 04:05:27 INFO - 'create-virtualenv', 04:05:27 INFO - 'install', 04:05:27 INFO - 'setup-mitmproxy', 04:05:27 INFO - 'run-tests'), 04:05:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:27 INFO - 'disable_ccov_upload': False, 04:05:27 INFO - 'disable_stylo': False, 04:05:27 INFO - 'download_minidump_stackwalk': True, 04:05:27 INFO - 'download_symbols': 'ondemand', 04:05:27 INFO - 'enable_stylo': False, 04:05:27 INFO - 'enable_webrender': False, 04:05:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:05:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:27 INFO - 'gecko_profile': False, 04:05:27 INFO - 'gecko_profile_interval': 0, 04:05:27 INFO - 'installer_path': 'installer.exe', 04:05:27 INFO - 'log_level': 'info', 04:05:27 INFO - 'log_name': 'talos', 04:05:27 INFO - 'log_to_console': True, 04:05:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:27 INFO - 'opt_config_files': (), 04:05:27 INFO - 'pip_index': False, 04:05:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:05:27 INFO - 'system_bits': '32', 04:05:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:27 INFO - 'title': 'talos-linux64-ix-013', 04:05:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:27 INFO - 'use_talos_json': True, 04:05:27 INFO - 'verify': 'False', 04:05:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:27 INFO - 'work_dir': 'build'} 04:05:27 INFO - [mozharness: 2017-09-26 11:05:27.609590Z] Running clobber step. 04:05:27 INFO - Running pre-action listener: _resource_record_pre_action 04:05:27 INFO - Running main action method: clobber 04:05:27 INFO - rmtree: /builds/slave/test/build 04:05:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:29 INFO - Running post-action listener: _resource_record_post_action 04:05:29 INFO - [mozharness: 2017-09-26 11:05:29.131502Z] Finished clobber step (success) 04:05:29 INFO - [mozharness: 2017-09-26 11:05:29.131598Z] Running read-buildbot-config step. 04:05:29 INFO - Running pre-action listener: _resource_record_pre_action 04:05:29 INFO - Running main action method: read_buildbot_config 04:05:29 INFO - Using buildbot properties: 04:05:29 INFO - { 04:05:29 INFO - "project": "", 04:05:29 INFO - "product": "firefox", 04:05:29 INFO - "who": "archaeopteryx@coole-files.de", 04:05:29 INFO - "installer_path": "public/build/target.tar.bz2", 04:05:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:05:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:05:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 04:05:29 INFO - "stage_platform": "linux64", 04:05:29 INFO - "basedir": "/builds/slave/test", 04:05:29 INFO - "buildnumber": 69, 04:05:29 INFO - "platform": "ubuntu64_hw", 04:05:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:29 INFO - "slavebuilddir": "test", 04:05:29 INFO - "taskId": "SrjCIfJ6RFGHJFKYD-ZXmw", 04:05:29 INFO - "branch": "mozilla-central", 04:05:29 INFO - "script_repo_revision": "production", 04:05:29 INFO - "revision": "6fb1f5fae37168c824b988733aac0d46499b6c11", 04:05:29 INFO - "slavename": "talos-linux64-ix-013", 04:05:29 INFO - "repo_path": "mozilla-central" 04:05:29 INFO - } 04:05:29 INFO - Finding installer, test and symbols from parent task. 04:05:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SrjCIfJ6RFGHJFKYD-ZXmw'}, attempt #1 04:05:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SrjCIfJ6RFGHJFKYD-ZXmw'}, attempt #1 04:05:30 INFO - Task dependencies: NZTur4OUTTCzffNcI7ihNw 04:05:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw'}, attempt #1 04:05:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json 04:05:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip 04:05:30 INFO - Running post-action listener: _resource_record_post_action 04:05:30 INFO - [mozharness: 2017-09-26 11:05:30.448602Z] Finished read-buildbot-config step (success) 04:05:30 INFO - [mozharness: 2017-09-26 11:05:30.448818Z] Running download-and-extract step. 04:05:30 INFO - Running pre-action listener: _resource_record_pre_action 04:05:30 INFO - Running main action method: download_and_extract 04:05:30 INFO - mkdir: /builds/slave/test/build/tests 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:30 INFO - trying https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json 04:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:05:31 INFO - Downloaded 989 bytes. 04:05:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:05:31 INFO - Using the following test package requirements: 04:05:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:05:31 INFO - u'common': [u'target.common.tests.zip'], 04:05:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:05:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:05:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:05:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:05:31 INFO - u'mozbase': [u'target.common.tests.zip'], 04:05:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:05:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:05:31 INFO - u'web-platform': [u'target.common.tests.zip', 04:05:31 INFO - u'target.web-platform.tests.tar.gz'], 04:05:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:05:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:05:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip 04:05:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:31 INFO - Fetch https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip into memory 04:05:32 INFO - Content-Length response header: 54943909 04:05:32 INFO - Bytes received: 54943909 04:05:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip 04:05:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:05:43 INFO - Fetch https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip into memory 04:05:45 INFO - Content-Length response header: 14513823 04:05:45 INFO - Bytes received: 14513823 04:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:45 INFO - trying https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:45 INFO - Downloading https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:05:49 INFO - Downloaded 61657450 bytes. 04:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:49 INFO - mkdir: /builds/slave/test/properties 04:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:49 INFO - Contents: 04:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - Running post-action listener: find_tests_for_verification 04:05:49 INFO - Running post-action listener: set_extra_try_arguments 04:05:49 INFO - [mozharness: 2017-09-26 11:05:49.732011Z] Finished download-and-extract step (success) 04:05:49 INFO - [mozharness: 2017-09-26 11:05:49.732110Z] Running populate-webroot step. 04:05:49 INFO - Running pre-action listener: _resource_record_pre_action 04:05:49 INFO - Running main action method: populate_webroot 04:05:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['tresize', 04:05:49 INFO - 'tcanvasmark']}, 04:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['dromaeo_css', 04:05:49 INFO - 'kraken']}, 04:05:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'tests': ['damp', 'tps']}, 04:05:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['damp', 'tps']}, 04:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['dromaeo_dom']}, 04:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:05:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['basic_compositor_video', 04:05:49 INFO - 'glvideo']}, 04:05:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:05:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['ts_paint_webext', 04:05:49 INFO - 'tp5o_webext']}, 04:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:49 INFO - 'ts_paint', 04:05:49 INFO - 'tpaint', 04:05:49 INFO - 'sessionrestore', 04:05:49 INFO - 'sessionrestore_many_windows', 04:05:49 INFO - 'sessionrestore_no_auto_restore', 04:05:49 INFO - 'tabpaint']}, 04:05:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['a11yr', 04:05:49 INFO - 'ts_paint', 04:05:49 INFO - 'tpaint', 04:05:49 INFO - 'sessionrestore', 04:05:49 INFO - 'sessionrestore_many_windows', 04:05:49 INFO - 'sessionrestore_no_auto_restore', 04:05:49 INFO - 'tabpaint']}, 04:05:49 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:05:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:05:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['perf_reftest_singletons']}, 04:05:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['perf_reftest']}, 04:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:49 INFO - 'tsvgr_opacity', 04:05:49 INFO - 'tart', 04:05:49 INFO - 'tscrollx', 04:05:49 INFO - 'tsvg_static']}, 04:05:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['tsvgx', 04:05:49 INFO - 'tsvgr_opacity', 04:05:49 INFO - 'tart', 04:05:49 INFO - 'tscrollx', 04:05:49 INFO - 'tsvg_static']}, 04:05:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:05:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--disable-stylo'], 04:05:49 INFO - 'tests': ['tp5o']}, 04:05:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:49 INFO - 'talos_options': ['--mitmproxy', 04:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:49 INFO - '--firstNonBlankPaint'], 04:05:49 INFO - 'tests': ['tp6_google', 04:05:49 INFO - 'tp6_youtube', 04:05:49 INFO - 'tp6_amazon', 04:05:49 INFO - 'tp6_facebook']}, 04:05:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:49 INFO - 'talos_options': ['--disable-stylo', 04:05:49 INFO - '--mitmproxy', 04:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:49 INFO - '--firstNonBlankPaint'], 04:05:49 INFO - 'tests': ['tp6_google', 04:05:49 INFO - 'tp6_youtube', 04:05:49 INFO - 'tp6_amazon', 04:05:49 INFO - 'tp6_facebook']}, 04:05:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:49 INFO - 'talos_options': ['--stylo-threads=1', 04:05:49 INFO - '--mitmproxy', 04:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:49 INFO - '--firstNonBlankPaint'], 04:05:49 INFO - 'tests': ['tp6_google', 04:05:49 INFO - 'tp6_youtube', 04:05:49 INFO - 'tp6_amazon', 04:05:49 INFO - 'tp6_facebook']}, 04:05:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--xperf_path', 04:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:49 INFO - 'tests': ['tp5n']}, 04:05:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:49 INFO - 'talos_options': ['--disable-stylo', 04:05:49 INFO - '--xperf_path', 04:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:49 INFO - 'tests': ['tp5n']}}} 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - [mozharness: 2017-09-26 11:05:49.755459Z] Finished populate-webroot step (success) 04:05:49 INFO - [mozharness: 2017-09-26 11:05:49.755548Z] Running create-virtualenv step. 04:05:49 INFO - Running pre-action listener: _resource_record_pre_action 04:05:49 INFO - Running main action method: create_virtualenv 04:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:05:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:50 INFO - Installing pip...............done. 04:05:50 INFO - Return code: 0 04:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:05:50 INFO - Reading from file tmpfile_stdout 04:05:50 INFO - Output received: 04:05:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:05:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05: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')]} 04:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05: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', 'pip>=1.5'] in /builds/slave/test/build 04:05: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 pip>=1.5 04:05:50 INFO - Using env: {'DISPLAY': ':0', 04:05:50 INFO - 'HOME': '/home/cltbld', 04:05:50 INFO - 'LANG': 'en_US.UTF-8', 04:05:50 INFO - 'LANGUAGE': 'en_US:en', 04:05:50 INFO - 'LOGNAME': 'cltbld', 04:05:50 INFO - 'MAIL': '/var/mail/cltbld', 04:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:50 INFO - 'MOZ_NO_REMOTE': '1', 04:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:50 INFO - 'NO_EM_RESTART': '1', 04:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:50 INFO - 'PWD': '/builds/slave/test', 04:05:50 INFO - 'SHELL': '/bin/bash', 04:05:50 INFO - 'SHLVL': '1', 04:05:50 INFO - 'TERM': 'linux', 04:05:50 INFO - 'TMOUT': '86400', 04:05:50 INFO - 'USER': 'cltbld', 04:05:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:50 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:05:51 INFO - Downloading/unpacking pip>=1.5 04:05:51 INFO - Running setup.py egg_info for package pip 04:05:51 INFO - warning: no files found matching 'pip/cacert.pem' 04:05:51 INFO - warning: no files found matching '*.html' under directory 'docs' 04:05:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:05:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:05:51 INFO - Installing collected packages: pip 04:05:51 INFO - Found existing installation: pip 1.1 04:05:51 INFO - Uninstalling pip: 04:05:51 INFO - Successfully uninstalled pip 04:05:51 INFO - Running setup.py install for pip 04:05:51 INFO - warning: no files found matching 'pip/cacert.pem' 04:05:51 INFO - warning: no files found matching '*.html' under directory 'docs' 04:05:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:05:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:05:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Successfully installed pip 04:05:51 INFO - Cleaning up... 04:05:51 INFO - Return code: 0 04:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:52 INFO - Downloading/unpacking psutil>=3.1.1 04:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:53 INFO - Installing collected packages: psutil 04:05:53 INFO - Running setup.py install for psutil 04:05:53 INFO - building 'psutil._psutil_linux' extension 04:05:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:05:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:05:53 INFO - building 'psutil._psutil_posix' extension 04:05:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:05:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:53 INFO - Successfully installed psutil 04:05:53 INFO - Cleaning up... 04:05:53 INFO - Return code: 0 04:05:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:53 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:05:53 INFO - Using env: {'DISPLAY': ':0', 04:05:53 INFO - 'HOME': '/home/cltbld', 04:05:53 INFO - 'LANG': 'en_US.UTF-8', 04:05:53 INFO - 'LANGUAGE': 'en_US:en', 04:05:53 INFO - 'LOGNAME': 'cltbld', 04:05:53 INFO - 'MAIL': '/var/mail/cltbld', 04:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:53 INFO - 'MOZ_NO_REMOTE': '1', 04:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:53 INFO - 'NO_EM_RESTART': '1', 04:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:53 INFO - 'PWD': '/builds/slave/test', 04:05:53 INFO - 'SHELL': '/bin/bash', 04:05:53 INFO - 'SHLVL': '1', 04:05:53 INFO - 'TERM': 'linux', 04:05:53 INFO - 'TMOUT': '86400', 04:05:53 INFO - 'USER': 'cltbld', 04:05:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:53 INFO - '_': '/tools/buildbot/bin/python'} 04:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05: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 04:05: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 04:05: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 04:05: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 04:05:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:55 INFO - Installing collected packages: mozsystemmonitor 04:05:55 INFO - Running setup.py install for mozsystemmonitor 04:05:55 INFO - Successfully installed mozsystemmonitor 04:05:55 INFO - Cleaning up... 04:05:55 INFO - Return code: 0 04:05:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:55 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:05:55 INFO - Using env: {'DISPLAY': ':0', 04:05:55 INFO - 'HOME': '/home/cltbld', 04:05:55 INFO - 'LANG': 'en_US.UTF-8', 04:05:55 INFO - 'LANGUAGE': 'en_US:en', 04:05:55 INFO - 'LOGNAME': 'cltbld', 04:05:55 INFO - 'MAIL': '/var/mail/cltbld', 04:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:55 INFO - 'MOZ_NO_REMOTE': '1', 04:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:55 INFO - 'NO_EM_RESTART': '1', 04:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:55 INFO - 'PWD': '/builds/slave/test', 04:05:55 INFO - 'SHELL': '/bin/bash', 04:05:55 INFO - 'SHLVL': '1', 04:05:55 INFO - 'TERM': 'linux', 04:05:55 INFO - 'TMOUT': '86400', 04:05:55 INFO - 'USER': 'cltbld', 04:05:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:55 INFO - '_': '/tools/buildbot/bin/python'} 04:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:05: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 04:05: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 04:05: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 04:05: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 04:05:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:05: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 04:05: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 04:05: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 04:05: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 04:05:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:57 INFO - warning: no files found matching '*.txt' 04:05:57 INFO - no previously-included directories found matching 'build' 04:05:57 INFO - no previously-included directories found matching 'dist' 04:05:57 INFO - no previously-included directories found matching '.git*' 04:05:57 INFO - Installing collected packages: jsonschema, functools32 04:05:57 INFO - Running setup.py install for functools32 04:05:57 INFO - warning: no files found matching '*.txt' 04:05:57 INFO - no previously-included directories found matching 'build' 04:05:57 INFO - no previously-included directories found matching 'dist' 04:05:57 INFO - no previously-included directories found matching '.git*' 04:05:57 INFO - Successfully installed jsonschema functools32 04:05:57 INFO - Cleaning up... 04:05:57 INFO - Return code: 0 04:05:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:05:57 INFO - Using env: {'DISPLAY': ':0', 04:05:57 INFO - 'HOME': '/home/cltbld', 04:05:57 INFO - 'LANG': 'en_US.UTF-8', 04:05:57 INFO - 'LANGUAGE': 'en_US:en', 04:05:57 INFO - 'LOGNAME': 'cltbld', 04:05:57 INFO - 'MAIL': '/var/mail/cltbld', 04:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:57 INFO - 'MOZ_NO_REMOTE': '1', 04:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:57 INFO - 'NO_EM_RESTART': '1', 04:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:57 INFO - 'PWD': '/builds/slave/test', 04:05:57 INFO - 'SHELL': '/bin/bash', 04:05:57 INFO - 'SHLVL': '1', 04:05:57 INFO - 'TERM': 'linux', 04:05:57 INFO - 'TMOUT': '86400', 04:05:57 INFO - 'USER': 'cltbld', 04:05:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:57 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05: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')]} 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:05:58 INFO - Using env: {'DISPLAY': ':0', 04:05:58 INFO - 'HOME': '/home/cltbld', 04:05:58 INFO - 'LANG': 'en_US.UTF-8', 04:05:58 INFO - 'LANGUAGE': 'en_US:en', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MAIL': '/var/mail/cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SHLVL': '1', 04:05:58 INFO - 'TERM': 'linux', 04:05:58 INFO - 'TMOUT': '86400', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:05: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 04:05: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 04:05: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 04:05: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 04:05:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - Downloading docopt-0.6.1.tar.gz 04:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:00 INFO - Running setup.py install for blobuploader 04:06:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:00 INFO - Running setup.py install for requests 04:06:00 INFO - Running setup.py install for docopt 04:06:00 INFO - Successfully installed blobuploader requests docopt 04:06:00 INFO - Cleaning up... 04:06:00 INFO - Return code: 0 04:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:00 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:00 INFO - Using env: {'DISPLAY': ':0', 04:06:00 INFO - 'HOME': '/home/cltbld', 04:06:00 INFO - 'LANG': 'en_US.UTF-8', 04:06:00 INFO - 'LANGUAGE': 'en_US:en', 04:06:00 INFO - 'LOGNAME': 'cltbld', 04:06:00 INFO - 'MAIL': '/var/mail/cltbld', 04:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:00 INFO - 'MOZ_NO_REMOTE': '1', 04:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:00 INFO - 'NO_EM_RESTART': '1', 04:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:00 INFO - 'PWD': '/builds/slave/test', 04:06:00 INFO - 'SHELL': '/bin/bash', 04:06:00 INFO - 'SHLVL': '1', 04:06:00 INFO - 'TERM': 'linux', 04:06:00 INFO - 'TMOUT': '86400', 04:06:00 INFO - 'USER': 'cltbld', 04:06:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:00 INFO - '_': '/tools/buildbot/bin/python'} 04:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:00 INFO - Running setup.py (path:/tmp/pip-mZfykI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:00 INFO - Running setup.py (path:/tmp/pip-wgnEz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:00 INFO - Running setup.py (path:/tmp/pip-45h7qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:01 INFO - Running setup.py (path:/tmp/pip-2FHcUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:01 INFO - Running setup.py (path:/tmp/pip-Xeh7iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:01 INFO - Running setup.py (path:/tmp/pip-aUAUK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:01 INFO - Running setup.py (path:/tmp/pip-9WYzWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:01 INFO - Running setup.py (path:/tmp/pip-CR3axk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:01 INFO - Running setup.py (path:/tmp/pip-_FkX1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:01 INFO - Running setup.py (path:/tmp/pip-6_Jbqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:01 INFO - Running setup.py (path:/tmp/pip-raw1dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:01 INFO - Running setup.py (path:/tmp/pip-Q49t7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:01 INFO - Running setup.py (path:/tmp/pip-ebAG2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:01 INFO - Running setup.py (path:/tmp/pip-k4Q23J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:01 INFO - Running setup.py (path:/tmp/pip-ufcNWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:01 INFO - Running setup.py (path:/tmp/pip-k1Omll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:01 INFO - Running setup.py (path:/tmp/pip-RQqj2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:02 INFO - Running setup.py install for manifestparser 04:06:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Running setup.py install for mozcrash 04:06:02 INFO - Running setup.py install for mozdebug 04:06:02 INFO - Running setup.py install for mozdevice 04:06:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Running setup.py install for mozfile 04:06:02 INFO - Running setup.py install for mozhttpd 04:06:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Running setup.py install for mozinfo 04:06:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Running setup.py install for mozInstall 04:06:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:02 INFO - Running setup.py install for mozleak 04:06:02 INFO - Running setup.py install for mozlog 04:06:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for moznetwork 04:06:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for mozprocess 04:06:03 INFO - Running setup.py install for mozprofile 04:06:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for mozrunner 04:06:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for mozscreenshot 04:06:03 INFO - Running setup.py install for moztest 04:06:03 INFO - Running setup.py install for mozversion 04:06:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:03 INFO - Cleaning up... 04:06:03 INFO - Return code: 0 04:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:03 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:03 INFO - Using env: {'DISPLAY': ':0', 04:06:03 INFO - 'HOME': '/home/cltbld', 04:06:03 INFO - 'LANG': 'en_US.UTF-8', 04:06:03 INFO - 'LANGUAGE': 'en_US:en', 04:06:03 INFO - 'LOGNAME': 'cltbld', 04:06:03 INFO - 'MAIL': '/var/mail/cltbld', 04:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:03 INFO - 'MOZ_NO_REMOTE': '1', 04:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:03 INFO - 'NO_EM_RESTART': '1', 04:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:03 INFO - 'PWD': '/builds/slave/test', 04:06:03 INFO - 'SHELL': '/bin/bash', 04:06:03 INFO - 'SHLVL': '1', 04:06:03 INFO - 'TERM': 'linux', 04:06:03 INFO - 'TMOUT': '86400', 04:06:03 INFO - 'USER': 'cltbld', 04:06:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:03 INFO - '_': '/tools/buildbot/bin/python'} 04:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:04 INFO - Running setup.py (path:/tmp/pip-HeYbyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:04 INFO - Running setup.py (path:/tmp/pip-3h1Zfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:04 INFO - Running setup.py (path:/tmp/pip-3eKiq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:04 INFO - Running setup.py (path:/tmp/pip-GYAaz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:04 INFO - Running setup.py (path:/tmp/pip-nWe1Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:04 INFO - Running setup.py (path:/tmp/pip-p0kZv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:04 INFO - Running setup.py (path:/tmp/pip-_5MDb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:04 INFO - Running setup.py (path:/tmp/pip-G10EN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:04 INFO - Running setup.py (path:/tmp/pip-SP6XxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:04 INFO - Running setup.py (path:/tmp/pip-Xd_PlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:04 INFO - Running setup.py (path:/tmp/pip-cEnwAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:04 INFO - Running setup.py (path:/tmp/pip-RmcrML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:04 INFO - Running setup.py (path:/tmp/pip-A5iKLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:04 INFO - Running setup.py (path:/tmp/pip-szR0oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:05 INFO - Running setup.py (path:/tmp/pip-p8WMCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:05 INFO - Running setup.py (path:/tmp/pip-BwkdbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:05 INFO - Running setup.py (path:/tmp/pip-foVDGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06: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 04:06: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 04:06: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 04:06: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 04:06:07 INFO - Downloading blessings-1.6.tar.gz 04:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:07 INFO - Installing collected packages: blessings 04:06:07 INFO - Running setup.py install for blessings 04:06:07 INFO - Successfully installed blessings 04:06:07 INFO - Cleaning up... 04:06:07 INFO - Return code: 0 04:06:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:07 INFO - Reading from file tmpfile_stdout 04:06:07 INFO - Current package versions: 04:06:07 INFO - argparse == 1.2.1 04:06:07 INFO - blessings == 1.6 04:06:07 INFO - blobuploader == 1.2.4 04:06:07 INFO - docopt == 0.6.1 04:06:07 INFO - functools32 == 3.2.3-2 04:06:07 INFO - jsonschema == 2.5.1 04:06:07 INFO - manifestparser == 1.1 04:06:07 INFO - mozInstall == 1.13 04:06:07 INFO - mozcrash == 1.0 04:06:07 INFO - mozdebug == 0.1 04:06:07 INFO - mozdevice == 0.51 04:06:07 INFO - mozfile == 1.2 04:06:07 INFO - mozhttpd == 0.7 04:06:07 INFO - mozinfo == 0.10 04:06:07 INFO - mozleak == 0.1 04:06:07 INFO - mozlog == 3.5 04:06:07 INFO - moznetwork == 0.27 04:06:07 INFO - mozprocess == 0.25 04:06:07 INFO - mozprofile == 0.28 04:06:07 INFO - mozrunner == 6.13 04:06:07 INFO - mozscreenshot == 0.1 04:06:07 INFO - mozsystemmonitor == 0.3 04:06:07 INFO - moztest == 0.8 04:06:07 INFO - mozversion == 1.4 04:06:07 INFO - psutil == 3.1.1 04:06:07 INFO - requests == 1.2.3 04:06:07 INFO - wsgiref == 0.1.2 04:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06: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')]} 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:07 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 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:07 INFO - Using env: {'DISPLAY': ':0', 04:06:07 INFO - 'HOME': '/home/cltbld', 04:06:07 INFO - 'LANG': 'en_US.UTF-8', 04:06:07 INFO - 'LANGUAGE': 'en_US:en', 04:06:07 INFO - 'LOGNAME': 'cltbld', 04:06:07 INFO - 'MAIL': '/var/mail/cltbld', 04:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:07 INFO - 'MOZ_NO_REMOTE': '1', 04:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:07 INFO - 'NO_EM_RESTART': '1', 04:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:07 INFO - 'PWD': '/builds/slave/test', 04:06:07 INFO - 'SHELL': '/bin/bash', 04:06:07 INFO - 'SHLVL': '1', 04:06:07 INFO - 'TERM': 'linux', 04:06:07 INFO - 'TMOUT': '86400', 04:06:07 INFO - 'USER': 'cltbld', 04:06:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:07 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:06:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:09 INFO - Installing collected packages: simplejson 04:06:09 INFO - Running setup.py install for simplejson 04:06:09 INFO - building 'simplejson._speedups' extension 04:06:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:06:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:06:10 INFO - Successfully installed simplejson 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Running post-action listener: _resource_record_post_action 04:06:10 INFO - Running post-action listener: _start_resource_monitoring 04:06:10 INFO - Starting resource monitoring. 04:06:10 INFO - [mozharness: 2017-09-26 11:06:10.521302Z] Finished create-virtualenv step (success) 04:06:10 INFO - [mozharness: 2017-09-26 11:06:10.521821Z] Running install step. 04:06:10 INFO - Running pre-action listener: _resource_record_pre_action 04:06:10 INFO - Running main action method: install 04:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:10 INFO - Reading from file tmpfile_stdout 04:06:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:10 INFO - Reading from file tmpfile_stdout 04:06:10 INFO - Output received: 04:06:10 INFO - Usage: mozinstall [options] installer 04:06:10 INFO - Options: 04:06:10 INFO - -h, --help show this help message and exit 04:06:10 INFO - -d DEST, --destination=DEST 04:06:10 INFO - Directory to install application into. [default: 04:06:10 INFO - "/builds/slave/test"] 04:06:10 INFO - --app=APP Application being installed. [default: firefox] 04:06:10 INFO - mkdir: /builds/slave/test/build/application 04:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:06:28 INFO - Reading from file tmpfile_stdout 04:06:28 INFO - Output received: 04:06:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - [mozharness: 2017-09-26 11:06:28.990506Z] Finished install step (success) 04:06:28 INFO - [mozharness: 2017-09-26 11:06:28.990651Z] Running setup-mitmproxy step. 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running main action method: setup_mitmproxy 04:06:28 INFO - Skipping: mitmproxy is not required 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - [mozharness: 2017-09-26 11:06:28.991201Z] Finished setup-mitmproxy step (success) 04:06:28 INFO - [mozharness: 2017-09-26 11:06:28.991452Z] Running run-tests step. 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running pre-action listener: _set_gcov_prefix 04:06:28 INFO - Running main action method: run_tests 04:06:28 WARNING - Try message not found. 04:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:29 INFO - Python 2.7.3 04:06:29 INFO - Return code: 0 04:06:29 INFO - grabbing minidump binary from tooltool 04:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:29 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 0x239bd60>, '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 0x239ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:29 INFO - Return code: 0 04:06:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:29 INFO - ENV: RUST_BACKTRACE is now full 04:06:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:29 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 04:06:29 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 04:06:29 INFO - Using env: {'DISPLAY': ':0', 04:06:29 INFO - 'HOME': '/home/cltbld', 04:06:29 INFO - 'LANG': 'en_US.UTF-8', 04:06:29 INFO - 'LANGUAGE': 'en_US:en', 04:06:29 INFO - 'LOGNAME': 'cltbld', 04:06:29 INFO - 'MAIL': '/var/mail/cltbld', 04:06:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:29 INFO - 'MOZ_NO_REMOTE': '1', 04:06:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:29 INFO - 'NO_EM_RESTART': '1', 04:06:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:29 INFO - 'PWD': '/builds/slave/test', 04:06:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:29 INFO - 'RUST_BACKTRACE': 'full', 04:06:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:29 INFO - 'SHELL': '/bin/bash', 04:06:29 INFO - 'SHLVL': '1', 04:06:29 INFO - 'TERM': 'linux', 04:06:29 INFO - 'TMOUT': '86400', 04:06:29 INFO - 'USER': 'cltbld', 04:06:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:29 INFO - '_': '/tools/buildbot/bin/python'} 04:06:29 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 04:06:29 INFO - mozversion application_buildid: 20170926095221 04:06:29 INFO - mozversion application_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:06:29 INFO - mozversion application_display_name: Nightly 04:06:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:29 INFO - mozversion application_name: Firefox 04:06:29 INFO - mozversion application_remotingname: firefox 04:06:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:29 INFO - mozversion application_vendor: Mozilla 04:06:29 INFO - mozversion application_version: 58.0a1 04:06:29 INFO - mozversion platform_buildid: 20170926095221 04:06:29 INFO - mozversion platform_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:06:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:29 INFO - mozversion platform_version: 58.0a1 04:06:29 INFO - using testdate: 1506423989 04:06:29 INFO - actual date: 1506423989 04:06:29 INFO - starting webserver on 'localhost:42783' 04:06:29 INFO - SUITE-START | Running 2 tests 04:06:29 INFO - TEST-START | dromaeo_css 04:06:29 INFO - Initialising browser for dromaeo_css test... 04:06:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42783/getInfo.html -profile /tmp/tmp9mDrSP/profile 04:06:29 INFO - TEST-INFO | started process 29194 (/builds/slave/test/build/application/firefox/firefox http://localhost:42783/getInfo.html) 04:06:34 INFO - TEST-INFO | 29194: exit 0 04:06:35 INFO - Browser initialized. 04:06:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:35 INFO - Using env: {'DISPLAY': ':0', 04:06:35 INFO - 'HOME': '/home/cltbld', 04:06:35 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:35 INFO - 'LANG': 'en_US.UTF-8', 04:06:35 INFO - 'LANGUAGE': 'en_US:en', 04:06:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:35 INFO - 'LOGNAME': 'cltbld', 04:06:35 INFO - 'MAIL': '/var/mail/cltbld', 04:06:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:35 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:35 INFO - 'MOZ_NO_REMOTE': '1', 04:06:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:35 INFO - 'NO_EM_RESTART': '1', 04:06:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:35 INFO - 'PWD': '/builds/slave/test', 04:06:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:35 INFO - 'RUST_BACKTRACE': 'full', 04:06:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:35 INFO - 'SHELL': '/bin/bash', 04:06:35 INFO - 'SHLVL': '1', 04:06:35 INFO - 'STYLO_FORCE_DISABLED': '1', 04:06:35 INFO - 'TERM': 'linux', 04:06:35 INFO - 'TMOUT': '86400', 04:06:35 INFO - 'USER': 'cltbld', 04:06:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:35 INFO - '_': '/tools/buildbot/bin/python'} 04:06:35 INFO - TEST-INFO | started process 29427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9mDrSP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:35 INFO - PID 29427 | 04:06:35 INFO - PID 29427 | (/builds/slave/test/build/application/firefox/firefox:29476): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:35 INFO - PID 29427 | 04:06:46 INFO - PID 29427 | RSS: Main: 153554944 04:06:46 INFO - PID 29427 | 04:09:43 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42783/tests/dromaeo/cssquery-ext.html) 04:09:44 INFO - PID 29427 | RSS: Main: 153399296 04:09:44 INFO - PID 29427 | 04:12:46 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-ext.html (next: http://localhost:42783/tests/dromaeo/cssquery-jquery.html) 04:12:46 INFO - PID 29427 | RSS: Main: 153538560 04:12:46 INFO - PID 29427 | 04:15:48 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42783/tests/dromaeo/cssquery-mootools.html) 04:15:49 INFO - PID 29427 | RSS: Main: 155832320 04:15:49 INFO - PID 29427 | 04:18:50 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42783/tests/dromaeo/cssquery-prototype.html) 04:18:51 INFO - PID 29427 | RSS: Main: 153665536 04:18:51 INFO - PID 29427 | 04:21:54 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42783/tests/dromaeo/cssquery-yui.html) 04:21:55 INFO - PID 29427 | RSS: Main: 154988544 04:21:55 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | Cycle 1(1): loaded http://localhost:42783/tests/dromaeo/cssquery-yui.html (next: http://localhost:42783/tests/dromaeo/cssquery-dojo.html) 04:24:57 INFO - PID 29427 | RSS: Main: 157777920 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | __start_tp_report 04:24:57 INFO - PID 29427 | _x_x_mozilla_page_load 04:24:57 INFO - PID 29427 | _x_x_mozilla_page_load_details 04:24:57 INFO - PID 29427 | |i|pagename|runs| 04:24:57 INFO - PID 29427 | |0;dojo.html;3135.8745650173996;3168.7306578940797;3169.3819705157503;3175.095097897098;3179.0939582219057;6262.467690246323;6284.371562843713;6347;6448.516361272906;6460.7092680829355;6286.119943207955;6344.555881088326;6357.55497115201;6379.234491860983;6394.712237949292;5796.97101514494;5802.39074897135;5814.8255552333285;5896.823095307148;5948.851278718045;5879.0593505039205;5885.234919460486;5889.646621202742;5958.851028724273;5966.164736936832;4.868242449928699;5660.433956604348;5844.1818145459665;5891.469767720904;5901.026330655458;5714.285714285715;5722.856928576777;5753.453421924953;5844.853878653025;5854.034084376073;5745.253117094751;5761.279840019997;5828.300603927556;5842.766289348421;5850.268716410449;6195.473384762301;6205.6897155142515;6397.616143031387;6410.102585638015;6413.935860641381;6773.119494465737;6781.389674929231;6848.2466928638305;6868.107146070979;6868.896966545506;6693.531452798306;6840.760573379957;6844;6934.861302773917;6938;6280.9685951569945;6326.841828954267;6337.271213810424;6338.429541341301;6340.778072767431;6782.355676210752;6894.172699276019;6897.931020689829;6917.342852429011;6984.196817365966;6649.069130321759;6714.597124172566;6760.256371799098;6774.864502709918;6781.050652908597;6811.4550835933005;6815.284395138439;6863.622500762406;6890.93109068913;6912.101426814583;6629.403353698094;6757.797266082025;6763.289854565298;6838.658067096625;6874.793756187322;6762.256151823295;6785.898211526831;6799.3200679931615;6802.965985170142;6810.5913645181445;5288.65623734456;5319;5336.67979921206;5344.144936810092;5351.812686555952;4585.518520555361;4711.246200607886;4748.548887855648;4749.548792864673;4756.096341695067;5775.971120144456;5852.414758524199;5887.61730487517;5897.823065308047;5900.6164599301765;6656.068150458939;6863.142107236596;6863.519553631198;6916.792496225121;6930.13373328334;5805.535557155502;5819.0689489681445;5825.88348233033;5826.65040097587;5829.067349224104;5794.710264486759;5860.912086318709;5895.233619629421;5909.645421274738;5917.260342457193;6549.541532092803;6616.636085015371;6630.303818099127;6631.801045968628;6697.430718388894;6825.249222585511;6825.829354265985;6836.179658441019;6927.584344939118;6974.895376569356;6395.040743888454;6429.6142231466265;6487.059376390492;6572.7042283098335;6581.440577550962;6715.127033485615;6752.797416077526;6758.155230596176;6774.627395493295;6782.253952065367;6902.827429314308;6911.481638877004;6982.581045137308;6996.300369962963;7000;6593.472522198309;6599.60402375859;6611.471082313307;6695.163104611924;6696.129503164558;6449.3873082057125;6584.440322572444;6597.5381723280825;6662.6335551545135;6667.566608170453;6515.413612774873;6590.308017658077;6601.570897891622;6627.105340778933;6642.43539299165;6691.297413771484;6698.5980841149685;6716.429103526255;6776;6807.353301436554;6326.082718005771;6442.645654489048;6447.3552644735155;6543.345665433419;6547.770828020996 04:24:57 INFO - PID 29427 | |1;ext.html;828.9958550207249;850.5449584472309;854.3805740837889;855.0252711908425;856.3620103023248;37881;41643.375349369744;42032.78983605081;42121;42138;39127.804360978225;39482.210355792864;39534.8023259884;39574;39586;7155.069840920673;7224.783256502314;7226.747063852767;7239.312265334785;7273.454490913176;7024.262452442496;7097.467689923276;7100.147982242138;7101.467389945749;7116.323949224816;7076.186238582552;7094.467914906377;7099;7815.374770018413;7978.361731061501;7888.60556972152;7951.681932722684;7953;7954.880676789853;7956.045274567031;7335.449841261927;7832.686692532292;7835.725749598737;7850.371970242424;7930.1276859545405;37407.625923740685;37882.81058594689;37902;37937.24125517474;37989.24021519554;3598.604153543108;3600.117971097072;3630.2920930418577;3636.690881275095;3645.6901163401144;31134.844325778453;31442.842785785924;31467;31560.210994725086;31590.684093159005;5197.22041693749;5263.026340127089;5264.947350526484;5266.025785229706;5284.128118860422;191608;191754;193225;193852;194653;40936.79531602323;41775.1644967105;46212;46243.76878115588;48597.757011214715;52113.2183017255;52228;52254.47745522572;52258;52271.21593176106;15914.442994495137;15966.60083497922;15992.280347384396;16055.197240137946;16115.274812633224;13202.933985330204;13245;13281.269530175932;13287.73424531504;13314.800277995837;13931.164130152021;13967.231802250973;14094;14139;14189.503367382093;5578.832635020955;5630.296212973379;5727.742251598688;5739.741711622987;5839.065749480063;994.174834887042;1006.1146191351564;1008.641932114089;1027.0448482910965;1029.8712660917386;23151.652725209136;23165.189218377276;23377.064917403455;23414.414639634146;23522.176723814926;1121.472907733364;1122.3097794856105;1122.854028976228;1125.5272785430138;1133.6769020829024;12285.69285767863;12420.378981050912;12451.501939922302;12455.314957677414;12560.183588066746;230366;230643;230723;230888;231273;52834.73582632062;52848.47151528512;53064;53072.46927530675;53350.73324633352;1395.2117053864533;1459.8540145985316;1464.2106786571599;1471.2129010979074;1472.0358165401678;22657.320280391614;23042.308730738103;23045;23271.534569308857;23374.415639609146;37417.2516549662;37496.25007499889;37558.43662345012;37588.436173457965;37618.24763504769;191452;191565;192196;192216;192266;30334.393312134074;32606.51090233696;33835.66164338325;34133.82933085319;34152.1461963443;41203.7939810311;42079;42838;42881.57118428776;43265.70202893918;31131.533027005065;31325;31453.213669658442;31516;31597.21006974844;31433.528497072104;31518.842405788742;31661.525077124323;31763.20591985219;32338.676613233565;34379.65620343765;35161.47257791186;35197;35212.64787352094;35425.1143721409;30935.535966960062;31036.379272413975;31050.689493105685;31532.842335788173;31748.682513175496;23234.3029709109;23565.64651530194;23728.40678983039;23825.285241442783;23937.880310598335 04:24:57 INFO - PID 29427 | |2;jquery.html;590.2621722846442;590.8995470769966;601.5127746525314;601.768319197109;613.368230722356;22202.444938876517;22776.43058923528;22968.77031229687;22978.770212297874;22992.08031678735;22375.664365034536;23717.525649487;23859.761402386015;23917;23977.160799372024;6438.1308523349335;6528.738850445977;6561.606303621774;6563.803085907407;6565.507586930999;6530.93469065308;6638.73445062197;6640.136782218305;6647.335266473362;6654.700538475756;6304.306526282106;6550.737970481175;6555.377239162296;6562.081308616797;6625.867482650344;6476.579022363531;6521.054447105191;6524.086627872101;6525.086487891699;6527.738890444377;5962.552808539377;6027.939720602782;6030.638161710312;6729.091572637681;7033.859322813566;29224.707752922623;29762.851185744148;29773.106806795615;29802;29843.552346714816;2038.1236068490543;2073.668213085899;2082.344061620585;2083.802038806311;2093.3196711068963;19263.13315900774;19675.508112297164;19689.9015504923;19894.70157947632;19919.40241792734;2458.2010846474786;2505.523950449409;2540.2379286214064;2560.3855074782105;2568.22953114065;124188.37905810504;130967;131264.343678281;133635;143163;19886.60226795456;20675.379738607866;21829.362797789912;21921.123155073936;22458.438539036655;42335.576644233166;42370.57629423728;42668;42890.78554607207;42919.141617168105;11204.159688023268;11222.102231821435;11231.494582743633;11310.660680179608;11536.596219132458;9346.672866449642;9396.90603093974;9440.386374885611;9484.336096473318;9555.713328600154;10914;10937.343759374464;10989.890101099047;11209.758048390355;11405.771884562262;3738.6074462181077;3946.723729338919;4089.468369112056;4160;4262.360645903077;927.536231884058;950.254050570299;951.2580187453797;953.696822174441;958.9232861371073;18442.815571844378;18618.34835780768;18703.34538291153;18740.15669294885;19136.330228442217;1008.7679833638305;1018.1549314069305;1023.0741179232806;1025.600015993763;1026.9640562580273;10292.330998485075;10560.891106433868;10613.469326533643;10614.310069845435;10630.46847657614;478801;485496;485544;486025;493206;111991;112357;112730.43634781774;113439.43280283711;115428;1029.5469993202967;1046.1317106801337;1146.518462245842;1195.6054502014488;1196.7905616517075;19544.609107818047;19620.607587848448;19635.70546441776;19841.900790495954;20095.497612559804;54703.45296547143;55433;55755;55797;56509;69845.30154698389;69920;70177.64911175412;71363.64318178376;71632;18967.241310347985;19351.4194574163;19465.318713844947;19631.018449077204;19634.214631414583;22234;22240.860279470933;22512.212072577382;22744.545109098057;23016.654750179096;17554.73667894957;17951.461456156336;18116.456506304832;18122.27510899549;18128.546786330448;15063.698726025637;15824.367025318857;16194.271257793192;16450.75323870119;16547.420840270534;18147.183376747813;18232.544186395447;18243.817561824744;18328.083595820422;18371.816281837546;19258.22967081301;19301.710474343177;19388.612227755082;19420.12609432607;19493.70759438581;16685.082320472004;16828.495145145665;17776.822231777518;17788.3774067907;18048.458546243633 04:24:57 INFO - PID 29427 | |3;mootools.html;1310.4954592481895;1361.8161548190994;1374.5395292576986;1377.5936098850839;1391.8121053657753;15118.773218401733;15850.762238566416;15876.206189690498;15878.206089695526;15890.52328430149;15205.4678086267;15301.540953771404;15349.155796431192;15361.539153825375;15417.3833046678;2758.544840101381;2762.1023167470553;2830.617866588015;2838.815476993989;2846.4734024205486;2720.4967081089962;2770.7229277072333;2771.3348796288847;2778.8193767405055;2784.025591043139;2726.986365068172;2813.535766598509;2831.7026712195234;2832.787540934428;2841.147655703291;2760.627315312427;2789.079603730764;2800.2439341377712;2806.116073436861;2815.225812901448;2574.472233192191;2784.3178421286916;2787.512185367573;2805.733455321741;2808.1715893811374;15422.922885385613;15424.845751542452;15546.378144874192;15581.92209038959;15605.219739013117;7994.760157195294;8220.58897055145;8297.25324720778;8314;8331.250187483094;5367.704776237344;5543.944560554383;5551.583631227674;5554.0835762099205;5603.075492543725;1897.7248298996706;1959.3827944197533;1968.4193163016944;2007.7992200779952;2021.433998480413;27255;27432.17703468899;27495.450090998067;27498.17505474839;27507.449851002868;6709.832254193587;6938.340857618518;6944.826379340557;6990.755323563651;7048.647567621599;17891.37380191687;17960;18002.819971800378;18023;18054.729179062324;7867.9606601966625;8035.0759662638375;8037.598120094089;8043.638036288381;8044.436889417684;7196.280371962866;7286.380657644054;7350.448716346188;7489.138749043821;7495.66269517873;5084.847454576368;5235.188545775411;5262.2632831403635;5292.603054770831;5302.39022512416;1532.9156896370584;1548.1872017191065;1548.79865617469;1549.1711934115194;1588.4043483693615;852.6674596907211;877.7191298784455;883.2095274729081;890.1854802855444;901.7069452427987;7501.949727038219;7547.16981132075;7554;7564.50830696003;7650.081990161217;711.3597762014125;712.9037579926644;715.2847152847153;729.7664747280925;731.3929438565978;4212.957870421318;4214.789260536961;4848.321235027099;5312.548433383128;5438.211459338374;21299.68050479244;21526.56946861054;21925.671114933288;22321.776782232293;22399.32802015942;21925.342239732832;22174.891255437164;22209.333719988103;22230.555013924044;22429.32712018642;11551.942240288912;11683.824742628867;11703.356315402565;11723.941380293214;11802.46888890002;8397.622107005078;8479.915200847912;8518.531480768617;8570.142985701379;8577.09940456243;18939.242430302635;19021.904890476013;19094.713579296043;19193.232270709017;19421.32025379105;19529.121189546222;19629.018549072774;19735.40793776189;19743.80256197477;19748.30880919161;11309.886901131213;11540.24988375753;11542.3651699154;11544.365059921785;11548.711282218012;14071.296435177996;14143.292835357985;14182.858171418155;14265.500707475188;14311.928440357731;11490.032526490026;11527;11677.941610292233;11812.17314787991;11989.160758746804;11038.227324087558;11069.391183484986;11265.436728163722;11348.943255283672;11448.771024579628;9924.503774811375;10179.287449878437;10219.13137383301;10223.795524089624;10229.590816367261;6547.443467305332;6697.598144111369;6711.865762684622;6718;6861.897071543831;7405.481616286808;7470;7499.550026998398;7518.360939320219;7573.507721998052 04:24:57 INFO - PID 29427 | |4;prototype.html;507.4925074925074;515.6287473019424;536.150201929941;543.5597166295298;544.825655790147;6173.3517980612005;6252.218472690914;6303.621782693036;6387.840303992402;6419.518536109787;6068.423499767526;6243;6248.31268560458;6281.183446151994;6285.497160227183;5010.473900240477;5032.043911656782;5055.140626093555;5085.135526960407;5095.910676622586;4883.560479556839;4995.150824359867;4995.900081998358;5070.670406423571;5140.8971820563565;5068.898622027557;5073.923891141636;5089.287499750038;5090.974545127269;5105.285260063594;5050.863555699956;5054.21659642756;5059;5059.671121377099;5097.923531147036;4546.954530454719;4559.224931761575;4584.518625544303;4601.677882548223;4628.32889231063;6220.751169953196;6236.282827474854;6249.562530622813;6296.9370306296805;6341.239051313826;5735.139729040678;5747.913781293284;5775.335836378787;5799.3620701722775;5799.739011744482;6559.836004099888;6609.438197753197;6654.866902661968;6674.265830758662;6689.264180940093;4957.429895562021;5013.799448022075;5013.799448022075;5014.498550144993;5015.3229314042865;6864.656767161672;6912.792616221522;6951.513394062417;6969.1985421676645;7002.544834585736;5101.285819985205;5106.693598384109;5112.514311140436;5125.692458452505;5127.8718032048755;5166.974165129225;5185.274061631375;5190.572592537007;5198.506141916512;5198.506141916512;5656.236408084856;5706.885862282731;5707.885842283131;5768.423157684282;5813.796517121965;6362.745490180341;6555.8361040973405;6621.635810030398;6633.341664583854;6638.7676431325635;1711.6662250861211;1712.2380540659535;1739.6607661506139;1780.8842425242317;1780.8931464112195;1244.6514975806788;1247.8627350991383;1248.5879659712273;1268.0489632775418;1274.7450509898058;5605.383407825136;5695.857603559944;5703.686297253691;5721.942780572224;5746.88506229873;6598.7030583623855;6683.331666833278;6780.559263647847;6812.386885180357;6826.590404575742;5811.128330750421;5828.5337173026055;5837.591368604242;5840.883182336414;5855.741015681564;3573.4997100405963;3581.832991040383;3595.6224596417;3597.5143355647174;3603.7837729736298;6556.311587283362;6583.868322633521;6589.571677841021;6602.372774586406;6631.734730610818;6795.684740190015;6960.825979350557;6986.615736134561;7023.683934222972;7082.433405327562;6464.676766161673;6503.804885853432;6513.316101809337;6518.740629685252;6571.507136964651;6748.7300507979135;6816.965915170393;6836.248012718497;6847;6852.691628876612;6781.864362712619;6787.864242715217;6789.219239787488;6789.660516974231;6857.657117144223;6362.300146983735;6488.221413430419;6629.436497897733;6675.833104172434;6707.262201157771;4990.326305948651;4997.300377947017;5053.59571234293;5084.491550844886;5099.184130539096;6643.136392269167;6787.66061696923;6801.265677252467;6817.625030623363;6859.519833611599;6273.7766135603115;6536.3136870627895;6537.411632953057;6552.541322107407;6573.474122070127;6557.770478033246;6564;6566.015097735378;6634.635095069818;6704.161979752531;6452.903206452001;6523.510736694672;6535.5425120241125;6538.346165383424;6539.574927629689;6609.801705948829;6616.801495955129;6630.535862489773;6644.136262285871;6685.231198412051;6433.839154021187;6455.483561315177;6465.903011454926;6483.384078512534;6520.608763474207 04:24:57 INFO - PID 29427 | |5;yui.html;890.0654312971379;900.3112618846579;901.8602116671918;908.2053203446982;913.8857642794651;19266.229350825968;19868.40394788155;19888.801111988876;19952.9002354988;20047;17951.640967180647;18173.363932262375;18238.088095595234;18253.26986920525;18296.817031829676;936.2229349639782;942.9387089839139;943.1040511514054;943.3113826906363;944.5182956692103;963.2631037256505;965.2037069417723;966.6375109334;967.4002118686424;969.9330736190204;993.438707130469;1019.94390308533;1022.7443139215196;1022.9028242316969;1027.542743479152;1001.4091685905278;1003.5634498992962;1003.7791685829106;1006.9647562335283;1007.1992765751208;723.6345645449068;736.1865139021357;741.3809469093313;746.787165657785;747.4132805747516;20005.899970500053;20205.8989705052;20295;20314.28899988508;20374.28689995843;21346.46633834151;21381.465463363384;21807.890960545254;22146.114155433763;22236.666450003264;17567.5608109797;17636;17671.11644417774;17774.822251777445;17791.644167116716;3771.113788259757;3783.035325991882;3783.867564635252;3784.186399924002;3799.9620003799882;108519;138353.3082334592;138693;139836.30081849627;141971;16702;16707;16891;16983.320667173175;17008.48974530766;31063.223419414244;31218.687813122033;31508.527372089437;31528;31617.20956976094;8759.649614015369;8999.32505062123;9040.773980650405;9157.267418606496;9169;4289.656827453796;4312.288472402019;4351.912961740747;4355.433793606874;4356.368326592689;5432.59255555827;5481.862953426196;5533.806316778974;5539.196816461671;5542.0301447246575;1073.3613499967507;1074.9355038697704;1086.2016417932814;1094.895984881435;1097.1497089755503;667.6528205333296;701.340739704676;703.4477934821141;719.1478098453349;719.6006216549761;11137.888621113847;11419;11811.527538898348;12056.758864822654;12126.059830427266;668.1848145262771;674.0798809624924;682.0825989044727;684.9657517124224;687.5118665747275;5427.375851777097;5463;5537.916931246034;5572.693501857356;5576.97211513948;120946.3952680231;123550.38224808818;123970.38014810049;125225.37387313005;128131;83499.16500835035;99359.50320248352;107158;107293.81662260508;111824;91629.1674166513;91925;92594.53702731578;94306.5284673586;94803;11713.297202167898;11735.589254376056;11819.11356648272;12153.210041347284;12226.572069977508;41960.16079678328;41991.7900410496;42078.36882446827;42221;43492.56507435012;55188.89622207614;55978;56130;56897.43102569087;57738.133927990275;17792.822071779116;18264.543386414913;18358.1738821756;18364.724529131807;18398.908005459885;21062.57874842525;21162.365129046153;21238.150473980866;21276;21400.143994240058;18510.16704248339;18515.074246287364;18552.44342669722;18573.907130464802;18783.624327513648;18634;18969.24123035063;18978.335758248395;19242.134103965636;19402.223911043966;17436.30254789845;17592.56018599545;17608.38370657021;17683.292668293125;17911.552211194823;12097.879021210027;12293.754124917272;12376.443060062498;12450.626481205578;12539.811902821648;12430.254184748945;12502.937485312515;12581.811272830731;12821;12845.293508857103 04:24:57 INFO - PID 29427 | __end_tp_report 04:24:57 INFO - PID 29427 | __start_cc_report 04:24:57 INFO - PID 29427 | _x_x_mozilla_cycle_collect,303 04:24:57 INFO - PID 29427 | __end_cc_report 04:24:57 INFO - PID 29427 | __startTimestamp1506425097282__endTimestamp 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | ------- Summary: start ------- 04:24:57 INFO - PID 29427 | Number of tests: 6 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#0] dojo.html Cycles:165 Average:6225.89 Median:6515.41 stddev:901.16 (13.8%) stddev-sans-first:870.71 04:24:57 INFO - PID 29427 | Values: 3135.9 3168.7 3169.4 3175.1 3179.1 6262.5 6284.4 6347.0 6448.5 6460.7 6286.1 6344.6 6357.6 6379.2 6394.7 5797.0 5802.4 5814.8 5896.8 5948.9 5879.1 5885.2 5889.6 5958.9 5966.2 4.9 5660.4 5844.2 5891.5 5901.0 5714.3 5722.9 5753.5 5844.9 5854.0 5745.3 5761.3 5828.3 5842.8 5850.3 6195.5 6205.7 6397.6 6410.1 6413.9 6773.1 6781.4 6848.2 6868.1 6868.9 6693.5 6840.8 6844.0 6934.9 6938.0 6281.0 6326.8 6337.3 6338.4 6340.8 6782.4 6894.2 6897.9 6917.3 6984.2 6649.1 6714.6 6760.3 6774.9 6781.1 6811.5 6815.3 6863.6 6890.9 6912.1 6629.4 6757.8 6763.3 6838.7 6874.8 6762.3 6785.9 6799.3 6803.0 6810.6 5288.7 5319.0 5336.7 5344.1 5351.8 4585.5 4711.2 4748.5 4749.5 4756.1 5776.0 5852.4 5887.6 5897.8 5900.6 6656.1 6863.1 6863.5 6916.8 6930.1 5805.5 5819.1 5825.9 5826.7 5829.1 5794.7 5860.9 5895.2 5909.6 5917.3 6549.5 6616.6 6630.3 6631.8 6697.4 6825.2 6825.8 6836.2 6927.6 6974.9 6395.0 6429.6 6487.1 6572.7 6581.4 6715.1 6752.8 6758.2 6774.6 6782.3 6902.8 6911.5 6982.6 6996.3 7000.0 6593.5 6599.6 6611.5 6695.2 6696.1 6449.4 6584.4 6597.5 6662.6 6667.6 6515.4 6590.3 6601.6 6627.1 6642.4 6691.3 6698.6 6716.4 6776.0 6807.4 6326.1 6442.6 6447.4 6543.3 6547.8 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#1] ext.html Cycles:180 Average:37233.33 Median:35179.24 stddev:53367.17 (151.7%) stddev-sans-first:53446.88 04:24:57 INFO - PID 29427 | Values: 829.0 850.5 854.4 855.0 856.4 37881.0 41643.4 42032.8 42121.0 42138.0 39127.8 39482.2 39534.8 39574.0 39586.0 7155.1 7224.8 7226.7 7239.3 7273.5 7024.3 7097.5 7100.1 7101.5 7116.3 7076.2 7094.5 7099.0 7815.4 7978.4 7888.6 7951.7 7953.0 7954.9 7956.0 7335.4 7832.7 7835.7 7850.4 7930.1 37407.6 37882.8 37902.0 37937.2 37989.2 3598.6 3600.1 3630.3 3636.7 3645.7 31134.8 31442.8 31467.0 31560.2 31590.7 5197.2 5263.0 5264.9 5266.0 5284.1 191608.0 191754.0 193225.0 193852.0 194653.0 40936.8 41775.2 46212.0 46243.8 48597.8 52113.2 52228.0 52254.5 52258.0 52271.2 15914.4 15966.6 15992.3 16055.2 16115.3 13202.9 13245.0 13281.3 13287.7 13314.8 13931.2 13967.2 14094.0 14139.0 14189.5 5578.8 5630.3 5727.7 5739.7 5839.1 994.2 1006.1 1008.6 1027.0 1029.9 23151.7 23165.2 23377.1 23414.4 23522.2 1121.5 1122.3 1122.9 1125.5 1133.7 12285.7 12420.4 12451.5 12455.3 12560.2 230366.0 230643.0 230723.0 230888.0 231273.0 52834.7 52848.5 53064.0 53072.5 53350.7 1395.2 1459.9 1464.2 1471.2 1472.0 22657.3 23042.3 23045.0 23271.5 23374.4 37417.3 37496.3 37558.4 37588.4 37618.2 191452.0 191565.0 192196.0 192216.0 192266.0 30334.4 32606.5 33835.7 34133.8 34152.1 41203.8 42079.0 42838.0 42881.6 43265.7 31131.5 31325.0 31453.2 31516.0 31597.2 31433.5 31518.8 31661.5 31763.2 32338.7 34379.7 35161.5 35197.0 35212.6 35425.1 30935.5 31036.4 31050.7 31532.8 31748.7 23234.3 23565.6 23728.4 23825.3 23937.9 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#2] jquery.html Cycles:180 Average:35398.15 Median:22237.43 stddev:81532.68 (366.6%) stddev-sans-first:81719.52 04:24:57 INFO - PID 29427 | Values: 590.3 590.9 601.5 601.8 613.4 22202.4 22776.4 22968.8 22978.8 22992.1 22375.7 23717.5 23859.8 23917.0 23977.2 6438.1 6528.7 6561.6 6563.8 6565.5 6530.9 6638.7 6640.1 6647.3 6654.7 6304.3 6550.7 6555.4 6562.1 6625.9 6476.6 6521.1 6524.1 6525.1 6527.7 5962.6 6027.9 6030.6 6729.1 7033.9 29224.7 29762.9 29773.1 29802.0 29843.6 2038.1 2073.7 2082.3 2083.8 2093.3 19263.1 19675.5 19689.9 19894.7 19919.4 2458.2 2505.5 2540.2 2560.4 2568.2 124188.4 130967.0 131264.3 133635.0 143163.0 19886.6 20675.4 21829.4 21921.1 22458.4 42335.6 42370.6 42668.0 42890.8 42919.1 11204.2 11222.1 11231.5 11310.7 11536.6 9346.7 9396.9 9440.4 9484.3 9555.7 10914.0 10937.3 10989.9 11209.8 11405.8 3738.6 3946.7 4089.5 4160.0 4262.4 927.5 950.3 951.3 953.7 958.9 18442.8 18618.3 18703.3 18740.2 19136.3 1008.8 1018.2 1023.1 1025.6 1027.0 10292.3 10560.9 10613.5 10614.3 10630.5 478801.0 485496.0 485544.0 486025.0 493206.0 111991.0 112357.0 112730.4 113439.4 115428.0 1029.5 1046.1 1146.5 1195.6 1196.8 19544.6 19620.6 19635.7 19841.9 20095.5 54703.5 55433.0 55755.0 55797.0 56509.0 69845.3 69920.0 70177.6 71363.6 71632.0 18967.2 19351.4 19465.3 19631.0 19634.2 22234.0 22240.9 22512.2 22744.5 23016.7 17554.7 17951.5 18116.5 18122.3 18128.5 15063.7 15824.4 16194.3 16450.8 16547.4 18147.2 18232.5 18243.8 18328.1 18371.8 19258.2 19301.7 19388.6 19420.1 19493.7 16685.1 16828.5 17776.8 17788.4 18048.5 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#3] mootools.html Cycles:180 Average:9504.05 Median:27502.81 stddev:6899.50 (25.1%) stddev-sans-first:6891.39 04:24:57 INFO - PID 29427 | Values: 1310.5 1361.8 1374.5 1377.6 1391.8 15118.8 15850.8 15876.2 15878.2 15890.5 15205.5 15301.5 15349.2 15361.5 15417.4 2758.5 2762.1 2830.6 2838.8 2846.5 2720.5 2770.7 2771.3 2778.8 2784.0 2727.0 2813.5 2831.7 2832.8 2841.1 2760.6 2789.1 2800.2 2806.1 2815.2 2574.5 2784.3 2787.5 2805.7 2808.2 15422.9 15424.8 15546.4 15581.9 15605.2 7994.8 8220.6 8297.3 8314.0 8331.3 5367.7 5543.9 5551.6 5554.1 5603.1 1897.7 1959.4 1968.4 2007.8 2021.4 27255.0 27432.2 27495.5 27498.2 27507.4 6709.8 6938.3 6944.8 6990.8 7048.6 17891.4 17960.0 18002.8 18023.0 18054.7 7868.0 8035.1 8037.6 8043.6 8044.4 7196.3 7286.4 7350.4 7489.1 7495.7 5084.8 5235.2 5262.3 5292.6 5302.4 1532.9 1548.2 1548.8 1549.2 1588.4 852.7 877.7 883.2 890.2 901.7 7501.9 7547.2 7554.0 7564.5 7650.1 711.4 712.9 715.3 729.8 731.4 4213.0 4214.8 4848.3 5312.5 5438.2 21299.7 21526.6 21925.7 22321.8 22399.3 21925.3 22174.9 22209.3 22230.6 22429.3 11551.9 11683.8 11703.4 11723.9 11802.5 8397.6 8479.9 8518.5 8570.1 8577.1 18939.2 19021.9 19094.7 19193.2 19421.3 19529.1 19629.0 19735.4 19743.8 19748.3 11309.9 11540.2 11542.4 11544.4 11548.7 14071.3 14143.3 14182.9 14265.5 14311.9 11490.0 11527.0 11677.9 11812.2 11989.2 11038.2 11069.4 11265.4 11348.9 11448.8 9924.5 10179.3 10219.1 10223.8 10229.6 6547.4 6697.6 6711.9 6718.0 6861.9 7405.5 7470.0 7499.6 7518.4 7573.5 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#4] prototype.html Cycles:180 Average:5577.04 Median:6248.94 stddev:1557.70 (24.9%) stddev-sans-first:1514.89 04:24:57 INFO - PID 29427 | Values: 507.5 515.6 536.2 543.6 544.8 6173.4 6252.2 6303.6 6387.8 6419.5 6068.4 6243.0 6248.3 6281.2 6285.5 5010.5 5032.0 5055.1 5085.1 5095.9 4883.6 4995.2 4995.9 5070.7 5140.9 5068.9 5073.9 5089.3 5091.0 5105.3 5050.9 5054.2 5059.0 5059.7 5097.9 4547.0 4559.2 4584.5 4601.7 4628.3 6220.8 6236.3 6249.6 6296.9 6341.2 5735.1 5747.9 5775.3 5799.4 5799.7 6559.8 6609.4 6654.9 6674.3 6689.3 4957.4 5013.8 5013.8 5014.5 5015.3 6864.7 6912.8 6951.5 6969.2 7002.5 5101.3 5106.7 5112.5 5125.7 5127.9 5167.0 5185.3 5190.6 5198.5 5198.5 5656.2 5706.9 5707.9 5768.4 5813.8 6362.7 6555.8 6621.6 6633.3 6638.8 1711.7 1712.2 1739.7 1780.9 1780.9 1244.7 1247.9 1248.6 1268.0 1274.7 5605.4 5695.9 5703.7 5721.9 5746.9 6598.7 6683.3 6780.6 6812.4 6826.6 5811.1 5828.5 5837.6 5840.9 5855.7 3573.5 3581.8 3595.6 3597.5 3603.8 6556.3 6583.9 6589.6 6602.4 6631.7 6795.7 6960.8 6986.6 7023.7 7082.4 6464.7 6503.8 6513.3 6518.7 6571.5 6748.7 6817.0 6836.2 6847.0 6852.7 6781.9 6787.9 6789.2 6789.7 6857.7 6362.3 6488.2 6629.4 6675.8 6707.3 4990.3 4997.3 5053.6 5084.5 5099.2 6643.1 6787.7 6801.3 6817.6 6859.5 6273.8 6536.3 6537.4 6552.5 6573.5 6557.8 6564.0 6566.0 6634.6 6704.2 6452.9 6523.5 6535.5 6538.3 6539.6 6609.8 6616.8 6630.5 6644.1 6685.2 6433.8 6455.5 6465.9 6483.4 6520.6 04:24:57 INFO - PID 29427 | 04:24:57 INFO - PID 29427 | [#5] yui.html Cycles:180 Average:24360.29 Median:20344.29 stddev:34232.02 (168.3%) stddev-sans-first:34282.69 04:24:57 INFO - PID 29427 | Values: 890.1 900.3 901.9 908.2 913.9 19266.2 19868.4 19888.8 19952.9 20047.0 17951.6 18173.4 18238.1 18253.3 18296.8 936.2 942.9 943.1 943.3 944.5 963.3 965.2 966.6 967.4 969.9 993.4 1019.9 1022.7 1022.9 1027.5 1001.4 1003.6 1003.8 1007.0 1007.2 723.6 736.2 741.4 746.8 747.4 20005.9 20205.9 20295.0 20314.3 20374.3 21346.5 21381.5 21807.9 22146.1 22236.7 17567.6 17636.0 17671.1 17774.8 17791.6 3771.1 3783.0 3783.9 3784.2 3800.0 108519.0 138353.3 138693.0 139836.3 141971.0 16702.0 16707.0 16891.0 16983.3 17008.5 31063.2 31218.7 31508.5 31528.0 31617.2 8759.6 8999.3 9040.8 9157.3 9169.0 4289.7 4312.3 4351.9 4355.4 4356.4 5432.6 5481.9 5533.8 5539.2 5542.0 1073.4 1074.9 1086.2 1094.9 1097.1 667.7 701.3 703.4 719.1 719.6 11137.9 11419.0 11811.5 12056.8 12126.1 668.2 674.1 682.1 685.0 687.5 5427.4 5463.0 5537.9 5572.7 5577.0 120946.4 123550.4 123970.4 125225.4 128131.0 83499.2 99359.5 107158.0 107293.8 111824.0 91629.2 91925.0 92594.5 94306.5 94803.0 11713.3 11735.6 11819.1 12153.2 12226.6 41960.2 41991.8 42078.4 42221.0 43492.6 55188.9 55978.0 56130.0 56897.4 57738.1 17792.8 18264.5 18358.2 18364.7 18398.9 21062.6 21162.4 21238.2 21276.0 21400.1 18510.2 18515.1 18552.4 18573.9 18783.6 18634.0 18969.2 18978.3 19242.1 19402.2 17436.3 17592.6 17608.4 17683.3 17911.6 12097.9 12293.8 12376.4 12450.6 12539.8 12430.3 12502.9 12581.8 12821.0 12845.3 04:24:57 INFO - PID 29427 | -------- Summary: end -------- 04:24:57 INFO - PID 29427 | 04:24:57 INFO - TEST-INFO | 29427: exit 0 04:24:57 INFO - TEST-OK | dromaeo_css | took 1108562ms 04:24:57 INFO - TEST-START | kraken 04:24:57 INFO - Initialising browser for kraken test... 04:24:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42783/getInfo.html -profile /tmp/tmp2Hxy1P/profile 04:24:57 INFO - TEST-INFO | started process 29794 (/builds/slave/test/build/application/firefox/firefox http://localhost:42783/getInfo.html) 04:25:03 INFO - TEST-INFO | 29794: exit 0 04:25:03 INFO - Browser initialized. 04:25:03 INFO - Running cycle 1/1 for kraken test... 04:25:03 INFO - Using env: {'DISPLAY': ':0', 04:25:03 INFO - 'HOME': '/home/cltbld', 04:25:03 INFO - 'JSGC_DISABLE_POISONING': '1', 04:25:03 INFO - 'LANG': 'en_US.UTF-8', 04:25:03 INFO - 'LANGUAGE': 'en_US:en', 04:25:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:25:03 INFO - 'LOGNAME': 'cltbld', 04:25:03 INFO - 'MAIL': '/var/mail/cltbld', 04:25:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:03 INFO - 'MOZ_CRASHREPORTER': '1', 04:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:25:03 INFO - 'MOZ_NO_REMOTE': '1', 04:25:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:03 INFO - 'NO_EM_RESTART': '1', 04:25:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:03 INFO - 'PWD': '/builds/slave/test', 04:25:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:03 INFO - 'RUST_BACKTRACE': 'full', 04:25:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:25:03 INFO - 'SHELL': '/bin/bash', 04:25:03 INFO - 'SHLVL': '1', 04:25:03 INFO - 'STYLO_FORCE_DISABLED': '1', 04:25:03 INFO - 'TERM': 'linux', 04:25:03 INFO - 'TMOUT': '86400', 04:25:03 INFO - 'USER': 'cltbld', 04:25:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265', 04:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:03 INFO - '_': '/tools/buildbot/bin/python'} 04:25:03 INFO - TEST-INFO | started process 30030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Hxy1P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:04 INFO - PID 30030 | 04:25:04 INFO - PID 30030 | (/builds/slave/test/build/application/firefox/firefox:30079): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:25:04 INFO - PID 30030 | 04:25:14 INFO - PID 30030 | RSS: Main: 151396352 04:25:14 INFO - PID 30030 | 04:25:17 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42783/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:18 INFO - PID 30030 | RSS: Main: 158621696 04:25:18 INFO - PID 30030 | 04:25:20 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42783/tests/kraken/driver.html?testName=audio-dft) 04:25:21 INFO - PID 30030 | RSS: Main: 158695424 04:25:21 INFO - PID 30030 | 04:25:24 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42783/tests/kraken/driver.html?testName=audio-fft) 04:25:24 INFO - PID 30030 | RSS: Main: 154750976 04:25:24 INFO - PID 30030 | 04:25:27 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42783/tests/kraken/driver.html?testName=audio-oscillator) 04:25:27 INFO - PID 30030 | RSS: Main: 155615232 04:25:27 INFO - PID 30030 | 04:25:29 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:30 INFO - PID 30030 | RSS: Main: 155824128 04:25:30 INFO - PID 30030 | 04:25:33 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42783/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:34 INFO - PID 30030 | RSS: Main: 157229056 04:25:34 INFO - PID 30030 | 04:25:37 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42783/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:38 INFO - PID 30030 | RSS: Main: 157417472 04:25:38 INFO - PID 30030 | 04:25:41 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42783/tests/kraken/driver.html?testName=json-parse-financial) 04:25:42 INFO - PID 30030 | RSS: Main: 157978624 04:25:42 INFO - PID 30030 | 04:25:43 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:44 INFO - PID 30030 | RSS: Main: 158240768 04:25:44 INFO - PID 30030 | 04:25:45 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:46 INFO - PID 30030 | RSS: Main: 158715904 04:25:46 INFO - PID 30030 | 04:25:48 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:49 INFO - PID 30030 | RSS: Main: 155328512 04:25:49 INFO - PID 30030 | 04:25:51 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:52 INFO - PID 30030 | RSS: Main: 155340800 04:25:52 INFO - PID 30030 | 04:25:55 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:56 INFO - PID 30030 | RSS: Main: 155918336 04:25:56 INFO - PID 30030 | 04:25:57 INFO - PID 30030 | Cycle 1(1): loaded http://localhost:42783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42783/tests/kraken/driver.html?testName=ai-astar) 04:25:58 INFO - PID 30030 | RSS: Main: 157274112 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | __start_tp_report 04:25:58 INFO - PID 30030 | _x_x_mozilla_page_load 04:25:58 INFO - PID 30030 | _x_x_mozilla_page_load_details 04:25:58 INFO - PID 30030 | |i|pagename|runs| 04:25:58 INFO - PID 30030 | |0;ai-astar;111;107;107;105;108;104;109;107;108;107 04:25:58 INFO - PID 30030 | |1;audio-beat-detection;117;118;120;117;122;117;116;118;140;120 04:25:58 INFO - PID 30030 | |2;audio-dft;164;161;164;163;162;162;162;164;169;162 04:25:58 INFO - PID 30030 | |3;audio-fft;74;75;74;73;75;75;74;74;73;75 04:25:58 INFO - PID 30030 | |4;audio-oscillator;80;80;80;80;79;79;81;81;82;80 04:25:58 INFO - PID 30030 | |5;imaging-gaussian-blur;109;114;117;113;114;110;115;113;113;115 04:25:58 INFO - PID 30030 | |6;imaging-darkroom;150;147;150;149;148;148;148;148;149;149 04:25:58 INFO - PID 30030 | |7;imaging-desaturate;94;96;97;96;94;94;95;96;94;96 04:25:58 INFO - PID 30030 | |8;json-parse-financial;54;54;55;52;54;54;54;53;54;54 04:25:58 INFO - PID 30030 | |9;json-stringify-tinderbox;37;38;37;38;38;39;38;38;39;38 04:25:58 INFO - PID 30030 | |10;stanford-crypto-aes;79;76;72;74;73;74;72;73;71;72 04:25:58 INFO - PID 30030 | |11;stanford-crypto-ccm;119;109;120;115;112;110;113;110;114;116 04:25:58 INFO - PID 30030 | |12;stanford-crypto-pbkdf2;176;168;165;167;166;170;173;171;168;169 04:25:58 INFO - PID 30030 | |13;stanford-crypto-sha256-iterative;70;69;67;74;63;63;66;66;68;67 04:25:58 INFO - PID 30030 | __end_tp_report 04:25:58 INFO - PID 30030 | __start_cc_report 04:25:58 INFO - PID 30030 | _x_x_mozilla_cycle_collect,749 04:25:58 INFO - PID 30030 | __end_cc_report 04:25:58 INFO - PID 30030 | __startTimestamp1506425158078__endTimestamp 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | ------- Summary: start ------- 04:25:58 INFO - PID 30030 | Number of tests: 14 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.50 stddev:1.95 (1.8%) stddev-sans-first:1.54 04:25:58 INFO - PID 30030 | Values: 111.0 107.0 107.0 105.0 108.0 104.0 109.0 107.0 108.0 107.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:119.00 stddev:7.09 (6.0%) stddev-sans-first:7.41 04:25:58 INFO - PID 30030 | Values: 117.0 118.0 120.0 117.0 122.0 117.0 116.0 118.0 140.0 120.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.39 04:25:58 INFO - PID 30030 | Values: 164.0 161.0 164.0 163.0 162.0 162.0 162.0 164.0 169.0 162.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 04:25:58 INFO - PID 30030 | Values: 74.0 75.0 74.0 73.0 75.0 75.0 74.0 74.0 73.0 75.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:80.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 04:25:58 INFO - PID 30030 | Values: 80.0 80.0 80.0 80.0 79.0 79.0 81.0 81.0 82.0 80.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:2.36 (2.1%) stddev-sans-first:1.92 04:25:58 INFO - PID 30030 | Values: 109.0 114.0 117.0 113.0 114.0 110.0 115.0 113.0 113.0 115.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 04:25:58 INFO - PID 30030 | Values: 150.0 147.0 150.0 149.0 148.0 148.0 148.0 148.0 149.0 149.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.12 04:25:58 INFO - PID 30030 | Values: 94.0 96.0 97.0 96.0 94.0 94.0 95.0 96.0 94.0 96.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 04:25:58 INFO - PID 30030 | Values: 54.0 54.0 55.0 52.0 54.0 54.0 54.0 53.0 54.0 54.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 04:25:58 INFO - PID 30030 | Values: 37.0 38.0 37.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:2.37 (3.2%) stddev-sans-first:1.50 04:25:58 INFO - PID 30030 | Values: 79.0 76.0 72.0 74.0 73.0 74.0 72.0 73.0 71.0 72.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:114.50 stddev:3.77 (3.3%) stddev-sans-first:3.49 04:25:58 INFO - PID 30030 | Values: 119.0 109.0 120.0 115.0 112.0 110.0 113.0 110.0 114.0 116.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:3.33 (2.0%) stddev-sans-first:2.51 04:25:58 INFO - PID 30030 | Values: 176.0 168.0 165.0 167.0 166.0 170.0 173.0 171.0 168.0 169.0 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:3.27 (4.8%) stddev-sans-first:3.32 04:25:58 INFO - PID 30030 | Values: 70.0 69.0 67.0 74.0 63.0 63.0 66.0 66.0 68.0 67.0 04:25:58 INFO - PID 30030 | -------- Summary: end -------- 04:25:58 INFO - PID 30030 | 04:25:58 INFO - PID 30030 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:25:58 INFO - TEST-INFO | 30030: exit 0 04:25:58 INFO - TEST-OK | kraken | took 60790ms 04:25:58 INFO - SUITE-END | took 1169s 04:25:58 INFO - Completed test suite (00:19:29) 04:25:58 INFO - javascript benchmark 04:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8644.444000411784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.8745650173996, 3168.7306578940797, 3169.3819705157503, 3175.095097897098, 3179.0939582219057, 6262.467690246323, 6284.371562843713, 6347.0, 6448.516361272906, 6460.7092680829355, 6286.119943207955, 6344.555881088326, 6357.55497115201, 6379.234491860983, 6394.712237949292, 5796.97101514494, 5802.39074897135, 5814.8255552333285, 5896.823095307148, 5948.851278718045, 5879.0593505039205, 5885.234919460486, 5889.646621202742, 5958.851028724273, 5966.164736936832, 4.868242449928699, 5660.433956604348, 5844.1818145459665, 5891.469767720904, 5901.026330655458, 5714.285714285715, 5722.856928576777, 5753.453421924953, 5844.853878653025, 5854.034084376073, 5745.253117094751, 5761.279840019997, 5828.300603927556, 5842.766289348421, 5850.268716410449, 6195.473384762301, 6205.6897155142515, 6397.616143031387, 6410.102585638015, 6413.935860641381, 6773.119494465737, 6781.389674929231, 6848.2466928638305, 6868.107146070979, 6868.896966545506, 6693.531452798306, 6840.760573379957, 6844.0, 6934.861302773917, 6938.0, 6280.9685951569945, 6326.841828954267, 6337.271213810424, 6338.429541341301, 6340.778072767431, 6782.355676210752, 6894.172699276019, 6897.931020689829, 6917.342852429011, 6984.196817365966, 6649.069130321759, 6714.597124172566, 6760.256371799098, 6774.864502709918, 6781.050652908597, 6811.4550835933005, 6815.284395138439, 6863.622500762406, 6890.93109068913, 6912.101426814583, 6629.403353698094, 6757.797266082025, 6763.289854565298, 6838.658067096625, 6874.793756187322, 6762.256151823295, 6785.898211526831, 6799.3200679931615, 6802.965985170142, 6810.5913645181445, 5288.65623734456, 5319.0, 5336.67979921206, 5344.144936810092, 5351.812686555952, 4585.518520555361, 4711.246200607886, 4748.548887855648, 4749.548792864673, 4756.096341695067, 5775.971120144456, 5852.414758524199, 5887.61730487517, 5897.823065308047, 5900.6164599301765, 6656.068150458939, 6863.142107236596, 6863.519553631198, 6916.792496225121, 6930.13373328334, 5805.535557155502, 5819.0689489681445, 5825.88348233033, 5826.65040097587, 5829.067349224104, 5794.710264486759, 5860.912086318709, 5895.233619629421, 5909.645421274738, 5917.260342457193, 6549.541532092803, 6616.636085015371, 6630.303818099127, 6631.801045968628, 6697.430718388894, 6825.249222585511, 6825.829354265985, 6836.179658441019, 6927.584344939118, 6974.895376569356, 6395.040743888454, 6429.6142231466265, 6487.059376390492, 6572.7042283098335, 6581.440577550962, 6715.127033485615, 6752.797416077526, 6758.155230596176, 6774.627395493295, 6782.253952065367, 6902.827429314308, 6911.481638877004, 6982.581045137308, 6996.300369962963, 7000.0, 6593.472522198309, 6599.60402375859, 6611.471082313307, 6695.163104611924, 6696.129503164558, 6449.3873082057125, 6584.440322572444, 6597.5381723280825, 6662.6335551545135, 6667.566608170453, 6515.413612774873, 6590.308017658077, 6601.570897891622, 6627.105340778933, 6642.43539299165, 6691.297413771484, 6698.5980841149685, 6716.429103526255, 6776.0, 6807.353301436554, 6326.082718005771, 6442.645654489048, 6447.3552644735155, 6543.345665433419, 6547.770828020996], "value": 6160.855442673061, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.9958550207249, 850.5449584472309, 854.3805740837889, 855.0252711908425, 856.3620103023248, 37881.0, 41643.375349369744, 42032.78983605081, 42121.0, 42138.0, 39127.804360978225, 39482.210355792864, 39534.8023259884, 39574.0, 39586.0, 7155.069840920673, 7224.783256502314, 7226.747063852767, 7239.312265334785, 7273.454490913176, 7024.262452442496, 7097.467689923276, 7100.147982242138, 7101.467389945749, 7116.323949224816, 7076.186238582552, 7094.467914906377, 7099.0, 7815.374770018413, 7978.361731061501, 7888.60556972152, 7951.681932722684, 7953.0, 7954.880676789853, 7956.045274567031, 7335.449841261927, 7832.686692532292, 7835.725749598737, 7850.371970242424, 7930.1276859545405, 37407.625923740685, 37882.81058594689, 37902.0, 37937.24125517474, 37989.24021519554, 3598.604153543108, 3600.117971097072, 3630.2920930418577, 3636.690881275095, 3645.6901163401144, 31134.844325778453, 31442.842785785924, 31467.0, 31560.210994725086, 31590.684093159005, 5197.22041693749, 5263.026340127089, 5264.947350526484, 5266.025785229706, 5284.128118860422, 191608.0, 191754.0, 193225.0, 193852.0, 194653.0, 40936.79531602323, 41775.1644967105, 46212.0, 46243.76878115588, 48597.757011214715, 52113.2183017255, 52228.0, 52254.47745522572, 52258.0, 52271.21593176106, 15914.442994495137, 15966.60083497922, 15992.280347384396, 16055.197240137946, 16115.274812633224, 13202.933985330204, 13245.0, 13281.269530175932, 13287.73424531504, 13314.800277995837, 13931.164130152021, 13967.231802250973, 14094.0, 14139.0, 14189.503367382093, 5578.832635020955, 5630.296212973379, 5727.742251598688, 5739.741711622987, 5839.065749480063, 994.174834887042, 1006.1146191351564, 1008.641932114089, 1027.0448482910965, 1029.8712660917386, 23151.652725209136, 23165.189218377276, 23377.064917403455, 23414.414639634146, 23522.176723814926, 1121.472907733364, 1122.3097794856105, 1122.854028976228, 1125.5272785430138, 1133.6769020829024, 12285.69285767863, 12420.378981050912, 12451.501939922302, 12455.314957677414, 12560.183588066746, 230366.0, 230643.0, 230723.0, 230888.0, 231273.0, 52834.73582632062, 52848.47151528512, 53064.0, 53072.46927530675, 53350.73324633352, 1395.2117053864533, 1459.8540145985316, 1464.2106786571599, 1471.2129010979074, 1472.0358165401678, 22657.320280391614, 23042.308730738103, 23045.0, 23271.534569308857, 23374.415639609146, 37417.2516549662, 37496.25007499889, 37558.43662345012, 37588.436173457965, 37618.24763504769, 191452.0, 191565.0, 192196.0, 192216.0, 192266.0, 30334.393312134074, 32606.51090233696, 33835.66164338325, 34133.82933085319, 34152.1461963443, 41203.7939810311, 42079.0, 42838.0, 42881.57118428776, 43265.70202893918, 31131.533027005065, 31325.0, 31453.213669658442, 31516.0, 31597.21006974844, 31433.528497072104, 31518.842405788742, 31661.525077124323, 31763.20591985219, 32338.676613233565, 34379.65620343765, 35161.47257791186, 35197.0, 35212.64787352094, 35425.1143721409, 30935.535966960062, 31036.379272413975, 31050.689493105685, 31532.842335788173, 31748.682513175496, 23234.3029709109, 23565.64651530194, 23728.40678983039, 23825.285241442783, 23937.880310598335], "value": 17003.91616702418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2621722846442, 590.8995470769966, 601.5127746525314, 601.768319197109, 613.368230722356, 22202.444938876517, 22776.43058923528, 22968.77031229687, 22978.770212297874, 22992.08031678735, 22375.664365034536, 23717.525649487, 23859.761402386015, 23917.0, 23977.160799372024, 6438.1308523349335, 6528.738850445977, 6561.606303621774, 6563.803085907407, 6565.507586930999, 6530.93469065308, 6638.73445062197, 6640.136782218305, 6647.335266473362, 6654.700538475756, 6304.306526282106, 6550.737970481175, 6555.377239162296, 6562.081308616797, 6625.867482650344, 6476.579022363531, 6521.054447105191, 6524.086627872101, 6525.086487891699, 6527.738890444377, 5962.552808539377, 6027.939720602782, 6030.638161710312, 6729.091572637681, 7033.859322813566, 29224.707752922623, 29762.851185744148, 29773.106806795615, 29802.0, 29843.552346714816, 2038.1236068490543, 2073.668213085899, 2082.344061620585, 2083.802038806311, 2093.3196711068963, 19263.13315900774, 19675.508112297164, 19689.9015504923, 19894.70157947632, 19919.40241792734, 2458.2010846474786, 2505.523950449409, 2540.2379286214064, 2560.3855074782105, 2568.22953114065, 124188.37905810504, 130967.0, 131264.343678281, 133635.0, 143163.0, 19886.60226795456, 20675.379738607866, 21829.362797789912, 21921.123155073936, 22458.438539036655, 42335.576644233166, 42370.57629423728, 42668.0, 42890.78554607207, 42919.141617168105, 11204.159688023268, 11222.102231821435, 11231.494582743633, 11310.660680179608, 11536.596219132458, 9346.672866449642, 9396.90603093974, 9440.386374885611, 9484.336096473318, 9555.713328600154, 10914.0, 10937.343759374464, 10989.890101099047, 11209.758048390355, 11405.771884562262, 3738.6074462181077, 3946.723729338919, 4089.468369112056, 4160.0, 4262.360645903077, 927.536231884058, 950.254050570299, 951.2580187453797, 953.696822174441, 958.9232861371073, 18442.815571844378, 18618.34835780768, 18703.34538291153, 18740.15669294885, 19136.330228442217, 1008.7679833638305, 1018.1549314069305, 1023.0741179232806, 1025.600015993763, 1026.9640562580273, 10292.330998485075, 10560.891106433868, 10613.469326533643, 10614.310069845435, 10630.46847657614, 478801.0, 485496.0, 485544.0, 486025.0, 493206.0, 111991.0, 112357.0, 112730.43634781774, 113439.43280283711, 115428.0, 1029.5469993202967, 1046.1317106801337, 1146.518462245842, 1195.6054502014488, 1196.7905616517075, 19544.609107818047, 19620.607587848448, 19635.70546441776, 19841.900790495954, 20095.497612559804, 54703.45296547143, 55433.0, 55755.0, 55797.0, 56509.0, 69845.30154698389, 69920.0, 70177.64911175412, 71363.64318178376, 71632.0, 18967.241310347985, 19351.4194574163, 19465.318713844947, 19631.018449077204, 19634.214631414583, 22234.0, 22240.860279470933, 22512.212072577382, 22744.545109098057, 23016.654750179096, 17554.73667894957, 17951.461456156336, 18116.456506304832, 18122.27510899549, 18128.546786330448, 15063.698726025637, 15824.367025318857, 16194.271257793192, 16450.75323870119, 16547.420840270534, 18147.183376747813, 18232.544186395447, 18243.817561824744, 18328.083595820422, 18371.816281837546, 19258.22967081301, 19301.710474343177, 19388.612227755082, 19420.12609432607, 19493.70759438581, 16685.082320472004, 16828.495145145665, 17776.822231777518, 17788.3774067907, 18048.458546243633], "value": 12651.217052724965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.4954592481895, 1361.8161548190994, 1374.5395292576986, 1377.5936098850839, 1391.8121053657753, 15118.773218401733, 15850.762238566416, 15876.206189690498, 15878.206089695526, 15890.52328430149, 15205.4678086267, 15301.540953771404, 15349.155796431192, 15361.539153825375, 15417.3833046678, 2758.544840101381, 2762.1023167470553, 2830.617866588015, 2838.815476993989, 2846.4734024205486, 2720.4967081089962, 2770.7229277072333, 2771.3348796288847, 2778.8193767405055, 2784.025591043139, 2726.986365068172, 2813.535766598509, 2831.7026712195234, 2832.787540934428, 2841.147655703291, 2760.627315312427, 2789.079603730764, 2800.2439341377712, 2806.116073436861, 2815.225812901448, 2574.472233192191, 2784.3178421286916, 2787.512185367573, 2805.733455321741, 2808.1715893811374, 15422.922885385613, 15424.845751542452, 15546.378144874192, 15581.92209038959, 15605.219739013117, 7994.760157195294, 8220.58897055145, 8297.25324720778, 8314.0, 8331.250187483094, 5367.704776237344, 5543.944560554383, 5551.583631227674, 5554.0835762099205, 5603.075492543725, 1897.7248298996706, 1959.3827944197533, 1968.4193163016944, 2007.7992200779952, 2021.433998480413, 27255.0, 27432.17703468899, 27495.450090998067, 27498.17505474839, 27507.449851002868, 6709.832254193587, 6938.340857618518, 6944.826379340557, 6990.755323563651, 7048.647567621599, 17891.37380191687, 17960.0, 18002.819971800378, 18023.0, 18054.729179062324, 7867.9606601966625, 8035.0759662638375, 8037.598120094089, 8043.638036288381, 8044.436889417684, 7196.280371962866, 7286.380657644054, 7350.448716346188, 7489.138749043821, 7495.66269517873, 5084.847454576368, 5235.188545775411, 5262.2632831403635, 5292.603054770831, 5302.39022512416, 1532.9156896370584, 1548.1872017191065, 1548.79865617469, 1549.1711934115194, 1588.4043483693615, 852.6674596907211, 877.7191298784455, 883.2095274729081, 890.1854802855444, 901.7069452427987, 7501.949727038219, 7547.16981132075, 7554.0, 7564.50830696003, 7650.081990161217, 711.3597762014125, 712.9037579926644, 715.2847152847153, 729.7664747280925, 731.3929438565978, 4212.957870421318, 4214.789260536961, 4848.321235027099, 5312.548433383128, 5438.211459338374, 21299.68050479244, 21526.56946861054, 21925.671114933288, 22321.776782232293, 22399.32802015942, 21925.342239732832, 22174.891255437164, 22209.333719988103, 22230.555013924044, 22429.32712018642, 11551.942240288912, 11683.824742628867, 11703.356315402565, 11723.941380293214, 11802.46888890002, 8397.622107005078, 8479.915200847912, 8518.531480768617, 8570.142985701379, 8577.09940456243, 18939.242430302635, 19021.904890476013, 19094.713579296043, 19193.232270709017, 19421.32025379105, 19529.121189546222, 19629.018549072774, 19735.40793776189, 19743.80256197477, 19748.30880919161, 11309.886901131213, 11540.24988375753, 11542.3651699154, 11544.365059921785, 11548.711282218012, 14071.296435177996, 14143.292835357985, 14182.858171418155, 14265.500707475188, 14311.928440357731, 11490.032526490026, 11527.0, 11677.941610292233, 11812.17314787991, 11989.160758746804, 11038.227324087558, 11069.391183484986, 11265.436728163722, 11348.943255283672, 11448.771024579628, 9924.503774811375, 10179.287449878437, 10219.13137383301, 10223.795524089624, 10229.590816367261, 6547.443467305332, 6697.598144111369, 6711.865762684622, 6718.0, 6861.897071543831, 7405.481616286808, 7470.0, 7499.550026998398, 7518.360939320219, 7573.507721998052], "value": 6710.30123203506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.4925074925074, 515.6287473019424, 536.150201929941, 543.5597166295298, 544.825655790147, 6173.3517980612005, 6252.218472690914, 6303.621782693036, 6387.840303992402, 6419.518536109787, 6068.423499767526, 6243.0, 6248.31268560458, 6281.183446151994, 6285.497160227183, 5010.473900240477, 5032.043911656782, 5055.140626093555, 5085.135526960407, 5095.910676622586, 4883.560479556839, 4995.150824359867, 4995.900081998358, 5070.670406423571, 5140.8971820563565, 5068.898622027557, 5073.923891141636, 5089.287499750038, 5090.974545127269, 5105.285260063594, 5050.863555699956, 5054.21659642756, 5059.0, 5059.671121377099, 5097.923531147036, 4546.954530454719, 4559.224931761575, 4584.518625544303, 4601.677882548223, 4628.32889231063, 6220.751169953196, 6236.282827474854, 6249.562530622813, 6296.9370306296805, 6341.239051313826, 5735.139729040678, 5747.913781293284, 5775.335836378787, 5799.3620701722775, 5799.739011744482, 6559.836004099888, 6609.438197753197, 6654.866902661968, 6674.265830758662, 6689.264180940093, 4957.429895562021, 5013.799448022075, 5013.799448022075, 5014.498550144993, 5015.3229314042865, 6864.656767161672, 6912.792616221522, 6951.513394062417, 6969.1985421676645, 7002.544834585736, 5101.285819985205, 5106.693598384109, 5112.514311140436, 5125.692458452505, 5127.8718032048755, 5166.974165129225, 5185.274061631375, 5190.572592537007, 5198.506141916512, 5198.506141916512, 5656.236408084856, 5706.885862282731, 5707.885842283131, 5768.423157684282, 5813.796517121965, 6362.745490180341, 6555.8361040973405, 6621.635810030398, 6633.341664583854, 6638.7676431325635, 1711.6662250861211, 1712.2380540659535, 1739.6607661506139, 1780.8842425242317, 1780.8931464112195, 1244.6514975806788, 1247.8627350991383, 1248.5879659712273, 1268.0489632775418, 1274.7450509898058, 5605.383407825136, 5695.857603559944, 5703.686297253691, 5721.942780572224, 5746.88506229873, 6598.7030583623855, 6683.331666833278, 6780.559263647847, 6812.386885180357, 6826.590404575742, 5811.128330750421, 5828.5337173026055, 5837.591368604242, 5840.883182336414, 5855.741015681564, 3573.4997100405963, 3581.832991040383, 3595.6224596417, 3597.5143355647174, 3603.7837729736298, 6556.311587283362, 6583.868322633521, 6589.571677841021, 6602.372774586406, 6631.734730610818, 6795.684740190015, 6960.825979350557, 6986.615736134561, 7023.683934222972, 7082.433405327562, 6464.676766161673, 6503.804885853432, 6513.316101809337, 6518.740629685252, 6571.507136964651, 6748.7300507979135, 6816.965915170393, 6836.248012718497, 6847.0, 6852.691628876612, 6781.864362712619, 6787.864242715217, 6789.219239787488, 6789.660516974231, 6857.657117144223, 6362.300146983735, 6488.221413430419, 6629.436497897733, 6675.833104172434, 6707.262201157771, 4990.326305948651, 4997.300377947017, 5053.59571234293, 5084.491550844886, 5099.184130539096, 6643.136392269167, 6787.66061696923, 6801.265677252467, 6817.625030623363, 6859.519833611599, 6273.7766135603115, 6536.3136870627895, 6537.411632953057, 6552.541322107407, 6573.474122070127, 6557.770478033246, 6564.0, 6566.015097735378, 6634.635095069818, 6704.161979752531, 6452.903206452001, 6523.510736694672, 6535.5425120241125, 6538.346165383424, 6539.574927629689, 6609.801705948829, 6616.801495955129, 6630.535862489773, 6644.136262285871, 6685.231198412051, 6433.839154021187, 6455.483561315177, 6465.903011454926, 6483.384078512534, 6520.608763474207], "value": 5120.668990461817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.0654312971379, 900.3112618846579, 901.8602116671918, 908.2053203446982, 913.8857642794651, 19266.229350825968, 19868.40394788155, 19888.801111988876, 19952.9002354988, 20047.0, 17951.640967180647, 18173.363932262375, 18238.088095595234, 18253.26986920525, 18296.817031829676, 936.2229349639782, 942.9387089839139, 943.1040511514054, 943.3113826906363, 944.5182956692103, 963.2631037256505, 965.2037069417723, 966.6375109334, 967.4002118686424, 969.9330736190204, 993.438707130469, 1019.94390308533, 1022.7443139215196, 1022.9028242316969, 1027.542743479152, 1001.4091685905278, 1003.5634498992962, 1003.7791685829106, 1006.9647562335283, 1007.1992765751208, 723.6345645449068, 736.1865139021357, 741.3809469093313, 746.787165657785, 747.4132805747516, 20005.899970500053, 20205.8989705052, 20295.0, 20314.28899988508, 20374.28689995843, 21346.46633834151, 21381.465463363384, 21807.890960545254, 22146.114155433763, 22236.666450003264, 17567.5608109797, 17636.0, 17671.11644417774, 17774.822251777445, 17791.644167116716, 3771.113788259757, 3783.035325991882, 3783.867564635252, 3784.186399924002, 3799.9620003799882, 108519.0, 138353.3082334592, 138693.0, 139836.30081849627, 141971.0, 16702.0, 16707.0, 16891.0, 16983.320667173175, 17008.48974530766, 31063.223419414244, 31218.687813122033, 31508.527372089437, 31528.0, 31617.20956976094, 8759.649614015369, 8999.32505062123, 9040.773980650405, 9157.267418606496, 9169.0, 4289.656827453796, 4312.288472402019, 4351.912961740747, 4355.433793606874, 4356.368326592689, 5432.59255555827, 5481.862953426196, 5533.806316778974, 5539.196816461671, 5542.0301447246575, 1073.3613499967507, 1074.9355038697704, 1086.2016417932814, 1094.895984881435, 1097.1497089755503, 667.6528205333296, 701.340739704676, 703.4477934821141, 719.1478098453349, 719.6006216549761, 11137.888621113847, 11419.0, 11811.527538898348, 12056.758864822654, 12126.059830427266, 668.1848145262771, 674.0798809624924, 682.0825989044727, 684.9657517124224, 687.5118665747275, 5427.375851777097, 5463.0, 5537.916931246034, 5572.693501857356, 5576.97211513948, 120946.3952680231, 123550.38224808818, 123970.38014810049, 125225.37387313005, 128131.0, 83499.16500835035, 99359.50320248352, 107158.0, 107293.81662260508, 111824.0, 91629.1674166513, 91925.0, 92594.53702731578, 94306.5284673586, 94803.0, 11713.297202167898, 11735.589254376056, 11819.11356648272, 12153.210041347284, 12226.572069977508, 41960.16079678328, 41991.7900410496, 42078.36882446827, 42221.0, 43492.56507435012, 55188.89622207614, 55978.0, 56130.0, 56897.43102569087, 57738.133927990275, 17792.822071779116, 18264.543386414913, 18358.1738821756, 18364.724529131807, 18398.908005459885, 21062.57874842525, 21162.365129046153, 21238.150473980866, 21276.0, 21400.143994240058, 18510.16704248339, 18515.074246287364, 18552.44342669722, 18573.907130464802, 18783.624327513648, 18634.0, 18969.24123035063, 18978.335758248395, 19242.134103965636, 19402.223911043966, 17436.30254789845, 17592.56018599545, 17608.38370657021, 17683.292668293125, 17911.552211194823, 12097.879021210027, 12293.754124917272, 12376.443060062498, 12450.626481205578, 12539.811902821648, 12430.254184748945, 12502.937485312515, 12581.811272830731, 12821.0, 12845.293508857103], "value": 9162.32180312095, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 107.0, 105.0, 108.0, 104.0, 109.0, 107.0, 108.0, 107.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 117.0, 122.0, 117.0, 116.0, 118.0, 140.0, 120.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 163.0, 162.0, 162.0, 162.0, 164.0, 169.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 73.0, 75.0, 75.0, 74.0, 74.0, 73.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 79.0, 81.0, 81.0, 82.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 117.0, 113.0, 114.0, 110.0, 115.0, 113.0, 113.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 97.0, 96.0, 94.0, 94.0, 95.0, 96.0, 94.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 52.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 72.0, 74.0, 73.0, 74.0, 72.0, 73.0, 71.0, 72.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 109.0, 120.0, 115.0, 112.0, 110.0, 113.0, 110.0, 114.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 168.0, 165.0, 167.0, 166.0, 170.0, 173.0, 171.0, 168.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 67.0, 74.0, 63.0, 63.0, 66.0, 66.0, 68.0, 67.0], "value": 67.3, "unit": "score"}]}]} 04:25:58 INFO - Return code: 0 04:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:25:58 INFO - # TBPL SUCCESS # 04:25:58 INFO - Running post-action listener: _package_coverage_data 04:25:58 INFO - Running post-action listener: _resource_record_post_action 04:25:58 INFO - [mozharness: 2017-09-26 11:25:58.874079Z] Finished run-tests step (success) 04:25:58 INFO - Running post-run listener: _resource_record_post_run 04:25:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 343932928; Read time: 12; Write time: 214068 04:25:58 INFO - TinderboxPrint: CPU usage
13.1% 04:25:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:25:58 INFO - TinderboxPrint: I/O write bytes / time
343,932,928 / 214,068 04:25:58 INFO - TinderboxPrint: CPU idle
8,228.8 (86.9%) 04:25:58 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 04:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:25:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13668352; Read time: 0; Write time: 2092 04:25:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:25:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 330264576; Read time: 0; Write time: 211976 04:25:59 INFO - Running post-run listener: _upload_blobber_files 04:25:59 INFO - Blob upload gear active. 04:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:59 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:25:59 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:25:59 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:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:01 INFO - (blobuploader) - INFO - Done attempting. 04:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:02 INFO - (blobuploader) - INFO - Done attempting. 04:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:09 INFO - (blobuploader) - INFO - Done attempting. 04:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:10 INFO - (blobuploader) - INFO - Done attempting. 04:26:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:10 INFO - Return code: 0 04:26:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e85faf2bf673ff661ade744000cc3b1d765edd86052c952ebb1b1b3cee5b2c2b76be860957c62675fe36f3e0ad2d35f06f4029214d4c814bd85173f33d3aa6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddcc0fdf749a91b0b26315a5e35de5f4f75e19a879bf09519ec7ea24b69c6627694c2c2a1541053be51965303d0aaaa4ebe55e4be74cb1a0ccae0fddf070a62e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bd508f2c813f20b6dae0acd95a41c5abb0a70fd80091c257fc7c64812b0ea923f97b52729b4497ee2d59f0c64b75225660aa7dbaa94e8e9e2cb38dc4fc9d4b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd2f30e727d83a42ce95b22de55a5f4923265050b01d87a693ddf64b147c58676b92bde2b440ebc731265a86c421e59f555706bab9e70b1ee2db300eb4b8ce93"} 04:26:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:10 INFO - Contents: 04:26:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e85faf2bf673ff661ade744000cc3b1d765edd86052c952ebb1b1b3cee5b2c2b76be860957c62675fe36f3e0ad2d35f06f4029214d4c814bd85173f33d3aa6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddcc0fdf749a91b0b26315a5e35de5f4f75e19a879bf09519ec7ea24b69c6627694c2c2a1541053be51965303d0aaaa4ebe55e4be74cb1a0ccae0fddf070a62e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bd508f2c813f20b6dae0acd95a41c5abb0a70fd80091c257fc7c64812b0ea923f97b52729b4497ee2d59f0c64b75225660aa7dbaa94e8e9e2cb38dc4fc9d4b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd2f30e727d83a42ce95b22de55a5f4923265050b01d87a693ddf64b147c58676b92bde2b440ebc731265a86c421e59f555706bab9e70b1ee2db300eb4b8ce93"} 04:26:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:10 INFO - Copying logs to upload dir... 04:26:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.449496 ========= master_lag: 0.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-26 04:26:10.912348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:10.920184) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 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/0e85faf2bf673ff661ade744000cc3b1d765edd86052c952ebb1b1b3cee5b2c2b76be860957c62675fe36f3e0ad2d35f06f4029214d4c814bd85173f33d3aa6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddcc0fdf749a91b0b26315a5e35de5f4f75e19a879bf09519ec7ea24b69c6627694c2c2a1541053be51965303d0aaaa4ebe55e4be74cb1a0ccae0fddf070a62e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bd508f2c813f20b6dae0acd95a41c5abb0a70fd80091c257fc7c64812b0ea923f97b52729b4497ee2d59f0c64b75225660aa7dbaa94e8e9e2cb38dc4fc9d4b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd2f30e727d83a42ce95b22de55a5f4923265050b01d87a693ddf64b147c58676b92bde2b440ebc731265a86c421e59f555706bab9e70b1ee2db300eb4b8ce93"} build_url:https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e85faf2bf673ff661ade744000cc3b1d765edd86052c952ebb1b1b3cee5b2c2b76be860957c62675fe36f3e0ad2d35f06f4029214d4c814bd85173f33d3aa6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddcc0fdf749a91b0b26315a5e35de5f4f75e19a879bf09519ec7ea24b69c6627694c2c2a1541053be51965303d0aaaa4ebe55e4be74cb1a0ccae0fddf070a62e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bd508f2c813f20b6dae0acd95a41c5abb0a70fd80091c257fc7c64812b0ea923f97b52729b4497ee2d59f0c64b75225660aa7dbaa94e8e9e2cb38dc4fc9d4b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd2f30e727d83a42ce95b22de55a5f4923265050b01d87a693ddf64b147c58676b92bde2b440ebc731265a86c421e59f555706bab9e70b1ee2db300eb4b8ce93"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:10.951378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:10.951716) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506423390.398589-1903253265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:11.030714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:26:11.031027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:26:11.031341) ========= ========= Total master_lag: 1.03 =========