builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1504788388.35 results: success (0) revision: 37b95547f0d27565452136d16b2df2857be840f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.345456) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.345856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.346122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.367736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.368021) ========= 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=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 05:46:28-- 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% 46.3M=0s 2017-09-07 05:46:28 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.492666) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.495977) ========= 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=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.545272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:28.545563) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37b95547f0d27565452136d16b2df2857be840f6 --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 37b95547f0d27565452136d16b2df2857be840f6 --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=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 05:46:28,464 truncating revision to first 12 chars 2017-09-07 05:46:28,464 Setting DEBUG logging. 2017-09-07 05:46:28,464 attempt 1/10 2017-09-07 05:46:28,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37b95547f0d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 05:46:28,909 unpacking tar archive at: mozilla-central-37b95547f0d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:29.297711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:29.297995) ========= script_repo_revision: 37b95547f0d27565452136d16b2df2857be840f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:29.298347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:29.298610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:46:29.314269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 05:46:29.314554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:29 INFO - MultiFileLogger online at 20170907 05:46:29 in /builds/slave/test 05:46:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:46:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:29 INFO - {'append_to_log': False, 05:46:29 INFO - 'base_work_dir': '/builds/slave/test', 05:46:29 INFO - 'blob_upload_branch': 'Firefox', 05:46:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:29 INFO - 'branch': 'Firefox', 05:46:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:29 INFO - 'code_coverage': False, 05:46:29 INFO - 'config_files': ('talos/linux_config.py',), 05:46:29 INFO - 'default_actions': ('clobber', 05:46:29 INFO - 'read-buildbot-config', 05:46:29 INFO - 'download-and-extract', 05:46:29 INFO - 'populate-webroot', 05:46:29 INFO - 'create-virtualenv', 05:46:29 INFO - 'install', 05:46:29 INFO - 'setup-mitmproxy', 05:46:29 INFO - 'run-tests'), 05:46:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:29 INFO - 'disable_ccov_upload': False, 05:46:29 INFO - 'disable_stylo': False, 05:46:29 INFO - 'download_minidump_stackwalk': True, 05:46:29 INFO - 'download_symbols': 'ondemand', 05:46:29 INFO - 'enable_stylo': False, 05:46:29 INFO - 'enable_webrender': False, 05:46:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:46:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:29 INFO - 'gecko_profile': False, 05:46:29 INFO - 'gecko_profile_interval': 0, 05:46:29 INFO - 'installer_path': 'installer.exe', 05:46:29 INFO - 'log_level': 'info', 05:46:29 INFO - 'log_name': 'talos', 05:46:29 INFO - 'log_to_console': True, 05:46:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:29 INFO - 'opt_config_files': (), 05:46:29 INFO - 'pip_index': False, 05:46:29 INFO - 'suite': 'dromaeojs-e10s', 05:46:29 INFO - 'system_bits': '32', 05:46:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:29 INFO - 'title': 'talos-linux64-ix-025', 05:46:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:29 INFO - 'use_talos_json': True, 05:46:29 INFO - 'verify': 'False', 05:46:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:29 INFO - 'work_dir': 'build'} 05:46:29 INFO - [mozharness: 2017-09-07 12:46:29.382883Z] Running clobber step. 05:46:29 INFO - Running pre-action listener: _resource_record_pre_action 05:46:29 INFO - Running main action method: clobber 05:46:29 INFO - rmtree: /builds/slave/test/build 05:46:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:30 INFO - Running post-action listener: _resource_record_post_action 05:46:30 INFO - [mozharness: 2017-09-07 12:46:30.893217Z] Finished clobber step (success) 05:46:30 INFO - [mozharness: 2017-09-07 12:46:30.893315Z] Running read-buildbot-config step. 05:46:30 INFO - Running pre-action listener: _resource_record_pre_action 05:46:30 INFO - Running main action method: read_buildbot_config 05:46:30 INFO - Using buildbot properties: 05:46:30 INFO - { 05:46:30 INFO - "project": "", 05:46:30 INFO - "product": "firefox", 05:46:30 INFO - "who": "archaeopteryx@coole-files.de", 05:46:30 INFO - "installer_path": "public/build/target.tar.bz2", 05:46:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:46:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:46:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:46:30 INFO - "stage_platform": "linux64-pgo", 05:46:30 INFO - "basedir": "/builds/slave/test", 05:46:30 INFO - "buildnumber": 143, 05:46:30 INFO - "platform": "ubuntu64_hw", 05:46:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:46:30 INFO - "slavebuilddir": "test", 05:46:30 INFO - "taskId": "Q0LKQbR1TduouzgbeW-Sdw", 05:46:30 INFO - "branch": "mozilla-central", 05:46:30 INFO - "script_repo_revision": "production", 05:46:30 INFO - "revision": "37b95547f0d27565452136d16b2df2857be840f6", 05:46:30 INFO - "slavename": "talos-linux64-ix-025", 05:46:30 INFO - "repo_path": "mozilla-central" 05:46:30 INFO - } 05:46:30 INFO - Finding installer, test and symbols from parent task. 05:46:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0LKQbR1TduouzgbeW-Sdw'}, attempt #1 05:46:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0LKQbR1TduouzgbeW-Sdw'}, attempt #1 05:46:31 INFO - Task dependencies: VXWD8froSPKZ2PF74DDRPw 05:46:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw'}, attempt #1 05:46:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 05:46:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.test_packages.json 05:46:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.crashreporter-symbols.zip 05:46:32 INFO - Running post-action listener: _resource_record_post_action 05:46:32 INFO - [mozharness: 2017-09-07 12:46:32.313195Z] Finished read-buildbot-config step (success) 05:46:32 INFO - [mozharness: 2017-09-07 12:46:32.313411Z] Running download-and-extract step. 05:46:32 INFO - Running pre-action listener: _resource_record_pre_action 05:46:32 INFO - Running main action method: download_and_extract 05:46:32 INFO - mkdir: /builds/slave/test/build/tests 05:46:32 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')]} 05:46:32 INFO - trying https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.test_packages.json 05:46:32 INFO - Downloading https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:46:32 INFO - Downloaded 989 bytes. 05:46:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:46:32 INFO - Using the following test package requirements: 05:46:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:46:32 INFO - u'common': [u'target.common.tests.zip'], 05:46:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:46:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:46:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:46:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:46:32 INFO - u'mozbase': [u'target.common.tests.zip'], 05:46:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:46:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:46:32 INFO - u'web-platform': [u'target.common.tests.zip', 05:46:32 INFO - u'target.web-platform.tests.tar.gz'], 05:46:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:46:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:46:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip 05:46:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:46:32 INFO - Fetch https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip into memory 05:46:34 INFO - Content-Length response header: 55689537 05:46:34 INFO - Bytes received: 55689537 05:46:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:46:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip 05:46:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:46:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.common.tests.zip into memory 05:46:46 INFO - Content-Length response header: 55689537 05:46:46 INFO - Bytes received: 55689537 05:47:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.talos.tests.zip 05:47:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:47:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.talos.tests.zip into memory 05:47:02 INFO - Content-Length response header: 14496665 05:47:02 INFO - Bytes received: 14496665 05:47: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')]} 05:47:03 INFO - trying https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 05:47:03 INFO - Downloading https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:47:04 INFO - Downloaded 63532377 bytes. 05:47:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 05:47:04 INFO - mkdir: /builds/slave/test/properties 05:47:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:04 INFO - Contents: 05:47:04 INFO - build_url:https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 05:47:04 INFO - Running post-action listener: _resource_record_post_action 05:47:04 INFO - Running post-action listener: find_tests_for_verification 05:47:04 INFO - Running post-action listener: set_extra_try_arguments 05:47:04 INFO - [mozharness: 2017-09-07 12:47:04.341674Z] Finished download-and-extract step (success) 05:47:04 INFO - [mozharness: 2017-09-07 12:47:04.341772Z] Running populate-webroot step. 05:47:04 INFO - Running pre-action listener: _resource_record_pre_action 05:47:04 INFO - Running main action method: populate_webroot 05:47:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['tresize', 05:47:04 INFO - 'tcanvasmark']}, 05:47:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['dromaeo_css', 05:47:04 INFO - 'kraken']}, 05:47:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'tests': ['damp', 'tps']}, 05:47:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['damp', 'tps']}, 05:47:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['dromaeo_dom']}, 05:47:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:47:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['basic_compositor_video', 05:47:04 INFO - 'glvideo']}, 05:47:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:47:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['ts_paint_webext', 05:47:04 INFO - 'tp5o_webext']}, 05:47:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:04 INFO - 'ts_paint', 05:47:04 INFO - 'tpaint', 05:47:04 INFO - 'sessionrestore', 05:47:04 INFO - 'sessionrestore_many_windows', 05:47:04 INFO - 'sessionrestore_no_auto_restore', 05:47:04 INFO - 'tabpaint']}, 05:47:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['a11yr', 05:47:04 INFO - 'ts_paint', 05:47:04 INFO - 'tpaint', 05:47:04 INFO - 'sessionrestore', 05:47:04 INFO - 'sessionrestore_many_windows', 05:47:04 INFO - 'sessionrestore_no_auto_restore', 05:47:04 INFO - 'tabpaint']}, 05:47:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:47:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:47:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['bloom_basic_singleton']}, 05:47:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['bloom_basic']}, 05:47:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:04 INFO - 'tsvgr_opacity', 05:47:04 INFO - 'tart', 05:47:04 INFO - 'tscrollx', 05:47:04 INFO - 'tsvg_static']}, 05:47:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['tsvgx', 05:47:04 INFO - 'tsvgr_opacity', 05:47:04 INFO - 'tart', 05:47:04 INFO - 'tscrollx', 05:47:04 INFO - 'tsvg_static']}, 05:47:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:47:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo'], 05:47:04 INFO - 'tests': ['tp5o']}, 05:47:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:47:04 INFO - 'talos_options': ['--mitmproxy', 05:47:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:47:04 INFO - '--firstNonBlankPaint'], 05:47:04 INFO - 'tests': ['tp6_google', 05:47:04 INFO - 'tp6_youtube', 05:47:04 INFO - 'tp6_amazon', 05:47:04 INFO - 'tp6_facebook']}, 05:47:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo', 05:47:04 INFO - '--mitmproxy', 05:47:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:47:04 INFO - '--firstNonBlankPaint'], 05:47:04 INFO - 'tests': ['tp6_google', 05:47:04 INFO - 'tp6_youtube', 05:47:04 INFO - 'tp6_amazon', 05:47:04 INFO - 'tp6_facebook']}, 05:47:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:47:04 INFO - 'talos_options': ['--stylo-threads=1', 05:47:04 INFO - '--mitmproxy', 05:47:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:47:04 INFO - '--firstNonBlankPaint'], 05:47:04 INFO - 'tests': ['tp6_google', 05:47:04 INFO - 'tp6_youtube', 05:47:04 INFO - 'tp6_amazon', 05:47:04 INFO - 'tp6_facebook']}, 05:47:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--xperf_path', 05:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:04 INFO - 'tests': ['tp5n']}, 05:47:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:47:04 INFO - 'talos_options': ['--disable-stylo', 05:47:04 INFO - '--xperf_path', 05:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:04 INFO - 'tests': ['tp5n']}}} 05:47:04 INFO - Running post-action listener: _resource_record_post_action 05:47:04 INFO - [mozharness: 2017-09-07 12:47:04.356889Z] Finished populate-webroot step (success) 05:47:04 INFO - [mozharness: 2017-09-07 12:47:04.356980Z] Running create-virtualenv step. 05:47:04 INFO - Running pre-action listener: _resource_record_pre_action 05:47:04 INFO - Running main action method: create_virtualenv 05:47:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:47:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:47:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:47:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:05 INFO - Installing pip...............done. 05:47:05 INFO - Return code: 0 05:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:47:05 INFO - Reading from file tmpfile_stdout 05:47:05 INFO - Output received: 05:47:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:47:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:05 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:05 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 05:47:05 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 05:47:05 INFO - Using env: {'DISPLAY': ':0', 05:47:05 INFO - 'HOME': '/home/cltbld', 05:47:05 INFO - 'LANG': 'en_US.UTF-8', 05:47:05 INFO - 'LANGUAGE': 'en_US:en', 05:47:05 INFO - 'LOGNAME': 'cltbld', 05:47:05 INFO - 'MAIL': '/var/mail/cltbld', 05:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:05 INFO - 'MOZ_NO_REMOTE': '1', 05:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:05 INFO - 'NO_EM_RESTART': '1', 05:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:05 INFO - 'PWD': '/builds/slave/test', 05:47:05 INFO - 'SHELL': '/bin/bash', 05:47:05 INFO - 'SHLVL': '1', 05:47:05 INFO - 'TERM': 'linux', 05:47:05 INFO - 'TMOUT': '86400', 05:47:05 INFO - 'USER': 'cltbld', 05:47:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:05 INFO - '_': '/tools/buildbot/bin/python'} 05:47:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:47:06 INFO - Downloading/unpacking pip>=1.5 05:47:06 INFO - Running setup.py egg_info for package pip 05:47:06 INFO - warning: no files found matching 'pip/cacert.pem' 05:47:06 INFO - warning: no files found matching '*.html' under directory 'docs' 05:47:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:47:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:47:06 INFO - Installing collected packages: pip 05:47:06 INFO - Found existing installation: pip 1.1 05:47:06 INFO - Uninstalling pip: 05:47:06 INFO - Successfully uninstalled pip 05:47:06 INFO - Running setup.py install for pip 05:47:06 INFO - warning: no files found matching 'pip/cacert.pem' 05:47:06 INFO - warning: no files found matching '*.html' under directory 'docs' 05:47:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:47:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:47:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:47:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:47:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:47:06 INFO - Successfully installed pip 05:47:06 INFO - Cleaning up... 05:47:06 INFO - Return code: 0 05:47:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:47:06 INFO - Using env: {'DISPLAY': ':0', 05:47:06 INFO - 'HOME': '/home/cltbld', 05:47:06 INFO - 'LANG': 'en_US.UTF-8', 05:47:06 INFO - 'LANGUAGE': 'en_US:en', 05:47:06 INFO - 'LOGNAME': 'cltbld', 05:47:06 INFO - 'MAIL': '/var/mail/cltbld', 05:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:06 INFO - 'MOZ_NO_REMOTE': '1', 05:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:06 INFO - 'NO_EM_RESTART': '1', 05:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:06 INFO - 'PWD': '/builds/slave/test', 05:47:06 INFO - 'SHELL': '/bin/bash', 05:47:06 INFO - 'SHLVL': '1', 05:47:06 INFO - 'TERM': 'linux', 05:47:06 INFO - 'TMOUT': '86400', 05:47:06 INFO - 'USER': 'cltbld', 05:47:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:06 INFO - '_': '/tools/buildbot/bin/python'} 05:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:06 INFO - Downloading/unpacking psutil>=3.1.1 05:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:07 INFO - Installing collected packages: psutil 05:47:07 INFO - Running setup.py install for psutil 05:47:08 INFO - building 'psutil._psutil_linux' extension 05:47:08 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 05:47:08 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 05:47:08 INFO - building 'psutil._psutil_posix' extension 05:47:08 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 05:47:08 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 05:47:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:08 INFO - Successfully installed psutil 05:47:08 INFO - Cleaning up... 05:47:08 INFO - Return code: 0 05:47:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:47:08 INFO - Using env: {'DISPLAY': ':0', 05:47:08 INFO - 'HOME': '/home/cltbld', 05:47:08 INFO - 'LANG': 'en_US.UTF-8', 05:47:08 INFO - 'LANGUAGE': 'en_US:en', 05:47:08 INFO - 'LOGNAME': 'cltbld', 05:47:08 INFO - 'MAIL': '/var/mail/cltbld', 05:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:08 INFO - 'MOZ_NO_REMOTE': '1', 05:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:08 INFO - 'NO_EM_RESTART': '1', 05:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:08 INFO - 'PWD': '/builds/slave/test', 05:47:08 INFO - 'SHELL': '/bin/bash', 05:47:08 INFO - 'SHLVL': '1', 05:47:08 INFO - 'TERM': 'linux', 05:47:08 INFO - 'TMOUT': '86400', 05:47:08 INFO - 'USER': 'cltbld', 05:47:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:08 INFO - '_': '/tools/buildbot/bin/python'} 05:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47: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 05:47: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 05:47: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 05:47: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 05:47:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:09 INFO - Installing collected packages: mozsystemmonitor 05:47:09 INFO - Running setup.py install for mozsystemmonitor 05:47:09 INFO - Successfully installed mozsystemmonitor 05:47:09 INFO - Cleaning up... 05:47:09 INFO - Return code: 0 05:47:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47:09 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')]} 05:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:09 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')]} 05:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:47:09 INFO - Using env: {'DISPLAY': ':0', 05:47:09 INFO - 'HOME': '/home/cltbld', 05:47:09 INFO - 'LANG': 'en_US.UTF-8', 05:47:09 INFO - 'LANGUAGE': 'en_US:en', 05:47:09 INFO - 'LOGNAME': 'cltbld', 05:47:09 INFO - 'MAIL': '/var/mail/cltbld', 05:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:09 INFO - 'MOZ_NO_REMOTE': '1', 05:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:09 INFO - 'NO_EM_RESTART': '1', 05:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:09 INFO - 'PWD': '/builds/slave/test', 05:47:09 INFO - 'SHELL': '/bin/bash', 05:47:09 INFO - 'SHLVL': '1', 05:47:09 INFO - 'TERM': 'linux', 05:47:09 INFO - 'TMOUT': '86400', 05:47:09 INFO - 'USER': 'cltbld', 05:47:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:09 INFO - '_': '/tools/buildbot/bin/python'} 05:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:10 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47:11 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 05:47:11 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 05:47:11 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 05:47:11 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 05:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:11 INFO - warning: no files found matching '*.txt' 05:47:11 INFO - no previously-included directories found matching 'build' 05:47:11 INFO - no previously-included directories found matching 'dist' 05:47:11 INFO - no previously-included directories found matching '.git*' 05:47:11 INFO - Installing collected packages: jsonschema, functools32 05:47:11 INFO - Running setup.py install for functools32 05:47:11 INFO - warning: no files found matching '*.txt' 05:47:11 INFO - no previously-included directories found matching 'build' 05:47:11 INFO - no previously-included directories found matching 'dist' 05:47:11 INFO - no previously-included directories found matching '.git*' 05:47:11 INFO - Successfully installed jsonschema functools32 05:47:11 INFO - Cleaning up... 05:47:11 INFO - Return code: 0 05:47:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:11 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:11 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 05:47:11 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 05:47:11 INFO - Using env: {'DISPLAY': ':0', 05:47:11 INFO - 'HOME': '/home/cltbld', 05:47:11 INFO - 'LANG': 'en_US.UTF-8', 05:47:11 INFO - 'LANGUAGE': 'en_US:en', 05:47:11 INFO - 'LOGNAME': 'cltbld', 05:47:11 INFO - 'MAIL': '/var/mail/cltbld', 05:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:11 INFO - 'MOZ_NO_REMOTE': '1', 05:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:11 INFO - 'NO_EM_RESTART': '1', 05:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:11 INFO - 'PWD': '/builds/slave/test', 05:47:11 INFO - 'SHELL': '/bin/bash', 05:47:11 INFO - 'SHLVL': '1', 05:47:11 INFO - 'TERM': 'linux', 05:47:11 INFO - 'TMOUT': '86400', 05:47:11 INFO - 'USER': 'cltbld', 05:47:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:11 INFO - '_': '/tools/buildbot/bin/python'} 05:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:47:11 INFO - Cleaning up... 05:47:11 INFO - Return code: 0 05:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:11 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:11 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 05:47:11 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 05:47:11 INFO - Using env: {'DISPLAY': ':0', 05:47:11 INFO - 'HOME': '/home/cltbld', 05:47:11 INFO - 'LANG': 'en_US.UTF-8', 05:47:11 INFO - 'LANGUAGE': 'en_US:en', 05:47:11 INFO - 'LOGNAME': 'cltbld', 05:47:11 INFO - 'MAIL': '/var/mail/cltbld', 05:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:11 INFO - 'MOZ_NO_REMOTE': '1', 05:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:11 INFO - 'NO_EM_RESTART': '1', 05:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:11 INFO - 'PWD': '/builds/slave/test', 05:47:11 INFO - 'SHELL': '/bin/bash', 05:47:11 INFO - 'SHLVL': '1', 05:47:11 INFO - 'TERM': 'linux', 05:47:11 INFO - 'TMOUT': '86400', 05:47:11 INFO - 'USER': 'cltbld', 05:47:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:11 INFO - '_': '/tools/buildbot/bin/python'} 05:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:12 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 05:47:12 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 05:47:12 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 05:47:12 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 05:47:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:13 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 05:47:13 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 05:47:13 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 05:47:13 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 05:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:13 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 05:47:13 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 05:47:13 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 05:47:13 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 05:47:13 INFO - Downloading docopt-0.6.1.tar.gz 05:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:13 INFO - Running setup.py install for blobuploader 05:47:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:13 INFO - Running setup.py install for requests 05:47:14 INFO - Running setup.py install for docopt 05:47:14 INFO - Successfully installed blobuploader requests docopt 05:47:14 INFO - Cleaning up... 05:47:14 INFO - Return code: 0 05:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:14 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')]} 05:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:14 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')]} 05:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:14 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:14 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 05:47:14 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 05:47:14 INFO - Using env: {'DISPLAY': ':0', 05:47:14 INFO - 'HOME': '/home/cltbld', 05:47:14 INFO - 'LANG': 'en_US.UTF-8', 05:47:14 INFO - 'LANGUAGE': 'en_US:en', 05:47:14 INFO - 'LOGNAME': 'cltbld', 05:47:14 INFO - 'MAIL': '/var/mail/cltbld', 05:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:14 INFO - 'MOZ_NO_REMOTE': '1', 05:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:14 INFO - 'NO_EM_RESTART': '1', 05:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:14 INFO - 'PWD': '/builds/slave/test', 05:47:14 INFO - 'SHELL': '/bin/bash', 05:47:14 INFO - 'SHLVL': '1', 05:47:14 INFO - 'TERM': 'linux', 05:47:14 INFO - 'TMOUT': '86400', 05:47:14 INFO - 'USER': 'cltbld', 05:47:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:14 INFO - '_': '/tools/buildbot/bin/python'} 05:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:14 INFO - Running setup.py (path:/tmp/pip-eBxrFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:14 INFO - Running setup.py (path:/tmp/pip-_I2qWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:14 INFO - Running setup.py (path:/tmp/pip-q85tZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:14 INFO - Running setup.py (path:/tmp/pip-X4FKeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:14 INFO - Running setup.py (path:/tmp/pip-FO_mnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:14 INFO - Running setup.py (path:/tmp/pip-cOvkTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:15 INFO - Running setup.py (path:/tmp/pip-xnYSbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:15 INFO - Running setup.py (path:/tmp/pip-3mHtAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:15 INFO - Running setup.py (path:/tmp/pip-Uiit56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:15 INFO - Running setup.py (path:/tmp/pip-xMdlFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:15 INFO - Running setup.py (path:/tmp/pip-YRjo7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:15 INFO - Running setup.py (path:/tmp/pip-ZJVrcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:15 INFO - Running setup.py (path:/tmp/pip-Cgctxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:15 INFO - Running setup.py (path:/tmp/pip-Ck87ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:15 INFO - Running setup.py (path:/tmp/pip-WHbebE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:15 INFO - Running setup.py (path:/tmp/pip-q3BDLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:15 INFO - Running setup.py (path:/tmp/pip-wd8fGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:15 INFO - Running setup.py install for manifestparser 05:47:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:15 INFO - Running setup.py install for mozcrash 05:47:16 INFO - Running setup.py install for mozdebug 05:47:16 INFO - Running setup.py install for mozdevice 05:47:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for mozfile 05:47:16 INFO - Running setup.py install for mozhttpd 05:47:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for mozinfo 05:47:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for mozInstall 05:47:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for mozleak 05:47:16 INFO - Running setup.py install for mozlog 05:47:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for moznetwork 05:47:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:16 INFO - Running setup.py install for mozprocess 05:47:17 INFO - Running setup.py install for mozprofile 05:47:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozrunner 05:47:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozscreenshot 05:47:17 INFO - Running setup.py install for moztest 05:47:17 INFO - Running setup.py install for mozversion 05:47:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:17 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')]} 05:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:17 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')]} 05:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:17 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:17 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 05:47:17 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 05:47:17 INFO - Using env: {'DISPLAY': ':0', 05:47:17 INFO - 'HOME': '/home/cltbld', 05:47:17 INFO - 'LANG': 'en_US.UTF-8', 05:47:17 INFO - 'LANGUAGE': 'en_US:en', 05:47:17 INFO - 'LOGNAME': 'cltbld', 05:47:17 INFO - 'MAIL': '/var/mail/cltbld', 05:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:17 INFO - 'MOZ_NO_REMOTE': '1', 05:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:17 INFO - 'NO_EM_RESTART': '1', 05:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:17 INFO - 'PWD': '/builds/slave/test', 05:47:17 INFO - 'SHELL': '/bin/bash', 05:47:17 INFO - 'SHLVL': '1', 05:47:17 INFO - 'TERM': 'linux', 05:47:17 INFO - 'TMOUT': '86400', 05:47:17 INFO - 'USER': 'cltbld', 05:47:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:17 INFO - '_': '/tools/buildbot/bin/python'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:17 INFO - Running setup.py (path:/tmp/pip-qGXSxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:17 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)) 05:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:17 INFO - Running setup.py (path:/tmp/pip-t1yCwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:17 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)) 05:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:17 INFO - Running setup.py (path:/tmp/pip-9UCaYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:17 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)) 05:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:17 INFO - Running setup.py (path:/tmp/pip-BwtAYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:18 INFO - Running setup.py (path:/tmp/pip-EDDx1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:18 INFO - Running setup.py (path:/tmp/pip-ingWYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:18 INFO - Running setup.py (path:/tmp/pip-_YD3kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:18 INFO - Running setup.py (path:/tmp/pip-GrCirU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:18 INFO - Running setup.py (path:/tmp/pip-0RLz3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:18 INFO - Running setup.py (path:/tmp/pip-TnNEQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:18 INFO - Running setup.py (path:/tmp/pip-GXHJCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:18 INFO - Running setup.py (path:/tmp/pip-L1ql24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:18 INFO - Running setup.py (path:/tmp/pip-DyPNcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:18 INFO - Running setup.py (path:/tmp/pip-2nR3nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:18 INFO - Running setup.py (path:/tmp/pip-WtqDRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:18 INFO - Running setup.py (path:/tmp/pip-B1OzGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:18 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)) 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:18 INFO - Running setup.py (path:/tmp/pip-LqVEt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:18 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)) 05:47:18 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)) 05:47:18 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)) 05:47:18 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)) 05:47:18 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)) 05:47:18 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)) 05:47:18 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)) 05:47:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:20 INFO - Downloading blessings-1.6.tar.gz 05:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:20 INFO - Installing collected packages: blessings 05:47:20 INFO - Running setup.py install for blessings 05:47:20 INFO - Successfully installed blessings 05:47:20 INFO - Cleaning up... 05:47:20 INFO - Return code: 0 05:47:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:20 INFO - Reading from file tmpfile_stdout 05:47:20 INFO - Current package versions: 05:47:20 INFO - argparse == 1.2.1 05:47:20 INFO - blessings == 1.6 05:47:20 INFO - blobuploader == 1.2.4 05:47:20 INFO - docopt == 0.6.1 05:47:20 INFO - functools32 == 3.2.3-2 05:47:20 INFO - jsonschema == 2.5.1 05:47:20 INFO - manifestparser == 1.1 05:47:20 INFO - mozInstall == 1.13 05:47:20 INFO - mozcrash == 1.0 05:47:20 INFO - mozdebug == 0.1 05:47:20 INFO - mozdevice == 0.51 05:47:20 INFO - mozfile == 1.2 05:47:20 INFO - mozhttpd == 0.7 05:47:20 INFO - mozinfo == 0.10 05:47:20 INFO - mozleak == 0.1 05:47:20 INFO - mozlog == 3.5 05:47:20 INFO - moznetwork == 0.27 05:47:20 INFO - mozprocess == 0.25 05:47:20 INFO - mozprofile == 0.28 05:47:20 INFO - mozrunner == 6.13 05:47:20 INFO - mozscreenshot == 0.1 05:47:20 INFO - mozsystemmonitor == 0.3 05:47:20 INFO - moztest == 0.8 05:47:20 INFO - mozversion == 1.4 05:47:20 INFO - psutil == 3.1.1 05:47:20 INFO - requests == 1.2.3 05:47:20 INFO - wsgiref == 0.1.2 05:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:20 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:20 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 05:47:20 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 05:47:20 INFO - Using env: {'DISPLAY': ':0', 05:47:20 INFO - 'HOME': '/home/cltbld', 05:47:20 INFO - 'LANG': 'en_US.UTF-8', 05:47:20 INFO - 'LANGUAGE': 'en_US:en', 05:47:20 INFO - 'LOGNAME': 'cltbld', 05:47:20 INFO - 'MAIL': '/var/mail/cltbld', 05:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:20 INFO - 'MOZ_NO_REMOTE': '1', 05:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:20 INFO - 'NO_EM_RESTART': '1', 05:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:20 INFO - 'PWD': '/builds/slave/test', 05:47:20 INFO - 'SHELL': '/bin/bash', 05:47:20 INFO - 'SHLVL': '1', 05:47:20 INFO - 'TERM': 'linux', 05:47:20 INFO - 'TMOUT': '86400', 05:47:20 INFO - 'USER': 'cltbld', 05:47:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:20 INFO - '_': '/tools/buildbot/bin/python'} 05:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 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)) 05:47:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:47:21 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)) 05:47:21 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)) 05:47:21 INFO - Installing collected packages: simplejson 05:47:21 INFO - Running setup.py install for simplejson 05:47:22 INFO - building 'simplejson._speedups' extension 05:47:22 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 05:47:22 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 05:47:22 INFO - Successfully installed simplejson 05:47:22 INFO - Cleaning up... 05:47:22 INFO - Return code: 0 05:47:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:22 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')]} 05:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:22 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')]} 05:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:23 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 0xa471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc10a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, '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': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', '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 05:47:23 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 05:47:23 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 05:47:23 INFO - Using env: {'DISPLAY': ':0', 05:47:23 INFO - 'HOME': '/home/cltbld', 05:47:23 INFO - 'LANG': 'en_US.UTF-8', 05:47:23 INFO - 'LANGUAGE': 'en_US:en', 05:47:23 INFO - 'LOGNAME': 'cltbld', 05:47:23 INFO - 'MAIL': '/var/mail/cltbld', 05:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:23 INFO - 'MOZ_NO_REMOTE': '1', 05:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:23 INFO - 'NO_EM_RESTART': '1', 05:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:23 INFO - 'PWD': '/builds/slave/test', 05:47:23 INFO - 'SHELL': '/bin/bash', 05:47:23 INFO - 'SHLVL': '1', 05:47:23 INFO - 'TERM': 'linux', 05:47:23 INFO - 'TMOUT': '86400', 05:47:23 INFO - 'USER': 'cltbld', 05:47:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:23 INFO - '_': '/tools/buildbot/bin/python'} 05:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:23 INFO - Cleaning up... 05:47:23 INFO - Return code: 0 05:47:23 INFO - Running post-action listener: _resource_record_post_action 05:47:23 INFO - Running post-action listener: _start_resource_monitoring 05:47:23 INFO - Starting resource monitoring. 05:47:23 INFO - [mozharness: 2017-09-07 12:47:23.272662Z] Finished create-virtualenv step (success) 05:47:23 INFO - [mozharness: 2017-09-07 12:47:23.273127Z] Running install step. 05:47:23 INFO - Running pre-action listener: _resource_record_pre_action 05:47:23 INFO - Running main action method: install 05:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:23 INFO - Reading from file tmpfile_stdout 05:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:23 INFO - Reading from file tmpfile_stdout 05:47:23 INFO - Output received: 05:47:23 INFO - Usage: mozinstall [options] installer 05:47:23 INFO - Options: 05:47:23 INFO - -h, --help show this help message and exit 05:47:23 INFO - -d DEST, --destination=DEST 05:47:23 INFO - Directory to install application into. [default: 05:47:23 INFO - "/builds/slave/test"] 05:47:23 INFO - --app=APP Application being installed. [default: firefox] 05:47:23 INFO - mkdir: /builds/slave/test/build/application 05:47:23 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'] 05:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:47:40 INFO - Reading from file tmpfile_stdout 05:47:40 INFO - Output received: 05:47:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - [mozharness: 2017-09-07 12:47:40.024548Z] Finished install step (success) 05:47:40 INFO - [mozharness: 2017-09-07 12:47:40.024695Z] Running setup-mitmproxy step. 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running main action method: setup_mitmproxy 05:47:40 INFO - Skipping: mitmproxy is not required 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - [mozharness: 2017-09-07 12:47:40.025227Z] Finished setup-mitmproxy step (success) 05:47:40 INFO - [mozharness: 2017-09-07 12:47:40.025328Z] Running run-tests step. 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running pre-action listener: _set_gcov_prefix 05:47:40 INFO - Running main action method: run_tests 05:47:40 WARNING - Try message not found. 05:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:40 INFO - Python 2.7.3 05:47:40 INFO - Return code: 0 05:47:40 INFO - grabbing minidump binary from tooltool 05:47:40 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')]} 05:47:40 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 0xdb7090>, '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 0xdb7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:40 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 05:47:40 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 05:47:40 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 05:47:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:40 INFO - Return code: 0 05:47:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:40 INFO - ENV: RUST_BACKTRACE is now full 05:47:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:47:40 INFO - Using env: {'DISPLAY': ':0', 05:47:40 INFO - 'HOME': '/home/cltbld', 05:47:40 INFO - 'LANG': 'en_US.UTF-8', 05:47:40 INFO - 'LANGUAGE': 'en_US:en', 05:47:40 INFO - 'LOGNAME': 'cltbld', 05:47:40 INFO - 'MAIL': '/var/mail/cltbld', 05:47:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:40 INFO - 'MOZ_NO_REMOTE': '1', 05:47:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:40 INFO - 'NO_EM_RESTART': '1', 05:47:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:40 INFO - 'PWD': '/builds/slave/test', 05:47:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:40 INFO - 'RUST_BACKTRACE': 'full', 05:47:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:47:40 INFO - 'SHELL': '/bin/bash', 05:47:40 INFO - 'SHLVL': '1', 05:47:40 INFO - 'TERM': 'linux', 05:47:40 INFO - 'TMOUT': '86400', 05:47:40 INFO - 'USER': 'cltbld', 05:47:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:40 INFO - '_': '/tools/buildbot/bin/python'} 05:47:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:47:40 INFO - mozversion application_buildid: 20170907103944 05:47:40 INFO - mozversion application_changeset: 37b95547f0d27565452136d16b2df2857be840f6 05:47:40 INFO - mozversion application_display_name: Nightly 05:47:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:40 INFO - mozversion application_name: Firefox 05:47:40 INFO - mozversion application_remotingname: firefox 05:47:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:40 INFO - mozversion application_vendor: Mozilla 05:47:40 INFO - mozversion application_version: 57.0a1 05:47:40 INFO - mozversion platform_buildid: 20170907103944 05:47:40 INFO - mozversion platform_changeset: 37b95547f0d27565452136d16b2df2857be840f6 05:47:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:40 INFO - mozversion platform_version: 57.0a1 05:47:40 INFO - using testdate: 1504788460 05:47:40 INFO - actual date: 1504788460 05:47:40 INFO - starting webserver on 'localhost:38675' 05:47:40 INFO - SUITE-START | Running 2 tests 05:47:40 INFO - TEST-START | dromaeo_css 05:47:40 INFO - Initialising browser for dromaeo_css test... 05:47:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38675/getInfo.html -profile /tmp/tmpLeulan/profile 05:47:40 INFO - TEST-INFO | started process 12497 (/builds/slave/test/build/application/firefox/firefox http://localhost:38675/getInfo.html) 05:47:46 INFO - TEST-INFO | 12497: exit 0 05:47:46 INFO - Browser initialized. 05:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:46 INFO - Using env: {'DISPLAY': ':0', 05:47:46 INFO - 'HOME': '/home/cltbld', 05:47:46 INFO - 'JSGC_DISABLE_POISONING': '1', 05:47:46 INFO - 'LANG': 'en_US.UTF-8', 05:47:46 INFO - 'LANGUAGE': 'en_US:en', 05:47:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:47:46 INFO - 'LOGNAME': 'cltbld', 05:47:46 INFO - 'MAIL': '/var/mail/cltbld', 05:47:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:46 INFO - 'MOZ_CRASHREPORTER': '1', 05:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:47:46 INFO - 'MOZ_NO_REMOTE': '1', 05:47:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:46 INFO - 'NO_EM_RESTART': '1', 05:47:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:46 INFO - 'PWD': '/builds/slave/test', 05:47:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:46 INFO - 'RUST_BACKTRACE': 'full', 05:47:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:47:46 INFO - 'SHELL': '/bin/bash', 05:47:46 INFO - 'SHLVL': '1', 05:47:46 INFO - 'TERM': 'linux', 05:47:46 INFO - 'TMOUT': '86400', 05:47:46 INFO - 'USER': 'cltbld', 05:47:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 05:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:46 INFO - '_': '/tools/buildbot/bin/python'} 05:47:46 INFO - TEST-INFO | started process 12696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLeulan/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:47 INFO - PID 12696 | 05:47:47 INFO - PID 12696 | (/builds/slave/test/build/application/firefox/firefox:12747): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:47:47 INFO - PID 12696 | 05:47:57 INFO - PID 12696 | RSS: Main: 163446784 05:47:57 INFO - PID 12696 | 05:50:54 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38675/tests/dromaeo/cssquery-ext.html) 05:50:55 INFO - PID 12696 | RSS: Main: 167038976 05:50:55 INFO - PID 12696 | 05:53:57 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-ext.html (next: http://localhost:38675/tests/dromaeo/cssquery-jquery.html) 05:53:57 INFO - PID 12696 | RSS: Main: 163753984 05:53:57 INFO - PID 12696 | 05:56:59 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38675/tests/dromaeo/cssquery-mootools.html) 05:57:00 INFO - PID 12696 | RSS: Main: 165642240 05:57:00 INFO - PID 12696 | 06:00:01 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38675/tests/dromaeo/cssquery-prototype.html) 06:00:02 INFO - PID 12696 | RSS: Main: 163368960 06:00:02 INFO - PID 12696 | 06:03:05 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38675/tests/dromaeo/cssquery-yui.html) 06:03:05 INFO - PID 12696 | RSS: Main: 165806080 06:03:05 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | Cycle 1(1): loaded http://localhost:38675/tests/dromaeo/cssquery-yui.html (next: http://localhost:38675/tests/dromaeo/cssquery-dojo.html) 06:06:07 INFO - PID 12696 | RSS: Main: 168910848 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | __start_tp_report 06:06:07 INFO - PID 12696 | _x_x_mozilla_page_load 06:06:07 INFO - PID 12696 | _x_x_mozilla_page_load_details 06:06:07 INFO - PID 12696 | |i|pagename|runs| 06:06:07 INFO - PID 12696 | |0;dojo.html;3830.0999265172663;3882.184741204347;3886.708496862735;3894.5715971243158;3907.4138879168104;6264.530160237978;6335;6368.076628888808;6382.393672601102;6454.612723236609;6375.4899608031365;6380.138681278037;6398.712057957391;6402.16771819664;6442.838929026777;5687.772489100431;5738.942610573903;5783.5084017858535;5792.4497172768515;5820.272465941757;5771.538276937856;5782.074868021117;5827.825165245049;5830.387809280028;5854.970725146369;89.61228212152251;5642.661440313574;5683.744231509592;5725.083986562172;5820.941790582082;5706.885862282731;5707.543396528268;5786.363500014995;5787;5798.246227990377;5701.800436984686;5702.857428564277;5756.453136952025;5765.250517432749;5788.826335209908;6263.123162757218;6337.6197428154;6400.615963042233;6404.935950640527;6424.614523128581;6864.897026544606;6878.621675807829;6939.028536004963;6952.582845029315;6972.267911869231;6839.384455398988;6915.239323674392;6935.930640693629;6991.755288564876;6995.475339349518;6400.0719895614875;6428.550001499897;6471.191101112361;6492.902606460907;6517.837054073639;7035.859282814315;7051.1891132519395;7094.822629434306;7148.106486689164;7151.499395042297;6667.099941507834;6763.560368576027;6803.251642319341;6815.625140617214;6886.48351373649;6831.795046148623;6835.179778426621;6840.31596840322;6843.7604683835825;6887.276835932155;6723.529352945345;6882.8967565486555;6889.173299204128;6892.517523773388;6897.41371983377;6823.93176068233;6830.94120411337;6842.349976752201;6923.6192009438955;6931.618760968196;4924.0890435268875;4974.253861920741;4990.850274491771;5055.494450554915;5056.974715126401;4552.180607490617;4567.474740404829;4644.535546445329;4662.417197850269;4662.557057079572;6290.6789574189015;6294.685265736694;6298.874022519615;6374.458171055419;6379.298277189506;6862.073620061228;6868.656567171622;6954.582725036514;6965.756198533129;6969.16370035599;6157.291911430243;6290.811275661737;6295.118683384329;6302.747890084437;6361.491080713532;5426.158945363475;5489.890202195934;5516.062269414209;5569.832905012856;5579.107342825128;7040.436765058783;7042.436605071582;7047.471439642048;7113.502054856214;7119.679614417364;6779.86440271182;6789.72841086351;6864.313568643096;6878.449724022066;6879.931200687929;6950.3049695030095;7039.084918960707;7055.470839686941;7057.294270572902;7061.788146355618;6720.596764194164;6760.357766012221;6779.966100169468;6801.761938332134;6825.658717064226;6822.829429264308;6837.62393068386;6933.168019837652;6938.826529336807;6974.546654467444;6618;6623.635700036544;6628.834279142867;6702.966485167543;6713.227978782503;6471.126397936218;6580.782555227298;6587.934120658732;6594.10979517759;6597;6601.240857301472;6601.570897891622;6667.399934005963;6671.132752742113;6675.666216689243;6682.198136223684;6726.024726414545;6831.077804496329;6834.589924604539;6847.48643851723;6372.267189273108;6506.512011599054;6523.3150519194805;6592.571482853599;6612.702428390638 06:06:07 INFO - PID 12696 | |1;ext.html;912.5482885971445;923.5751554285029;941.2234906202384;956.9186619137373;962.4946902875989;43457.56542434578;43582.7820860896;44345.334819977725;44403;44503.55496445035;44821.551784482144;45242.77378613102;45301;45630.77184614072;45709.542904570946;8051.758447246577;8242.793930151764;8259.21537453941;8277.95861020694;8287.337013038972;7938.206179382045;8017.478863873829;8019.919800801976;8019.95990020052;8024.2376974187655;7991.680332786682;7992.440529162961;8034.758957231293;8044.316233120192;8067.515949043076;7915.960420197891;7964.283214510693;7978.920210797875;8021.518708877456;8032.598370081531;8090.838183236361;8108.75673729789;8117.59412029402;8126.268635822746;8127.065387480457;39806.60193398087;40029.79985100085;40053.19893602141;40177.598224017675;40282.597174028175;3739.139997800521;3786.8863934082024;3800.1449673823445;3806.3148633246005;3807.7144214184045;33410;33508.83245583781;33516.6648333516;33519.49720754191;33552.83223583891;5389.164679474648;5409.864753381157;5416.458354164592;5426.158945363475;5516.393196748354;217160;218121;218325;219078;219592.9999999984;50248.74875625598;50569;50718.746406268474;50823.23765143526;50839;53833.730831345594;53978.19032714512;54011.45988540064;54040.189397159076;54058;14852;14960.551183464513;14977.550673479813;14993.025453345497;14998.47505337308;11872.287662740264;11915.940420297842;11944.16390852632;11947.342896140623;11952.40237988097;13908.721825563433;14264.286785660675;14304.856951430353;14305.284735763378;14362.281885905662;5270.446603106619;5288.286081378965;5334.59990500714;5463.562914966793;5475.589330800206;1045.6813360819917;1055.8205105131992;1074.9462526873624;1075.5694925748735;1084.1001968366238;31846.363072738415;31997.68002319947;32456.02631921046;32559.837200813843;32646.83676581602;1128.1595211567435;1140.0822338017974;1150.2810743285447;1151.090638395675;1153.037213926381;13366.465341386236;13445;13648.863511364958;13726.725465490634;17500.737488937677;270770;271058;271268;286934;292055;61323.69338153281;61337.386626133164;61436;61439;61674.38325616776;1448.0659974316718;1451.637090727318;1454.8036015138032;1470.5147301390516;1479.5931118942162;29454.410911781215;29679.703202967696;29775.255618609706;30405.543916840823;30407.54388684127;39941.20117597574;40019;40035;40057;40143.99999999883;230654;230863;231642;232823;233681;36469.45295820512;36504.26218033605;36504.45243321406;37142.62857371392;38159.61840381672;49479;50077.49922500728;50109.74945125251;50197.24704129368;50600.49399505958;36684.26631467409;36698.26603467862;36755.08112297214;36889.26221475609;37108.81445592863;36176.09559761027;36251.27497450089;36331.636683633886;36388.636113639586;36561.26877462489;42652.36021459743;42654.57345426506;42875.142497150504;43054;43099.56900430955;35001;35277;35469.82265088658;35737.821310893276;35768.28463430769;26153.869230653723;26637.200883973514;27066.458670826865;27227.183184504498;27534.44931101407 06:06:07 INFO - PID 12696 | |2;jquery.html;592.6621825559433;597.166952101818;599.961002534835;613.2089604410311;618.6102755264183;23239.302820915356;24201.91091400887;24258.393540161505;24261.87869060652;24296.87851560744;24807.503849922992;25998;26103.216903492877;26114.869425652843;26151;6620.139381880349;6667.466602671775;6753.763618273361;6755.729770809162;6760.3577660122455;6485.675716214194;6615.206175258975;6694.129763130786;6732.394084532416;6739.157605299338;6677.766278180265;6691.26396096429;6691.933080669204;6693.564918280296;6695.832604184886;6678.56589321695;6685.231198412196;6688.699008544627;6691.197056353269;6695.598264104169;6248.406401391906;6255.343188965138;6256.405641464099;6264.624122552661;6279.811605651837;28137.718622813714;29014.12957611275;29120;29280.267993300124;29499;2203.2178576605234;2242.686023956631;2243.663450482424;2243.6858839762444;2244.9887750561143;20005.49986250341;20269.695954560695;20897.89551052235;20981.265655701976;20985.8950705247;2536.518061568296;2585.276122685651;2589.8834552445187;2591.676040494938;2648.4835457085874;139504;142823;143927.28036359855;145440;153262.23368883197;16012.679746405007;16180.271887765079;16490.257938392562;16515.504534863972;16576.585585360222;25466.618000730003;25473.363165921;25499;25503.87248063785;25534.23397298084;9483.241340692728;9483.478408687588;9547.188488978514;9584.952075239578;9623.422594644344;8187.877181842158;8248.092709801916;8266.669333226724;8273.751787446266;8324.916750832414;9778.462184579774;9950.900490994998;9989;10023.298369114093;10100.343477673927;2906.3170155013554;2936.9706302936697;2967.169192626025;2976.4939960206816;3017.4719424100695;1039.2880876599554;1051.2903789941759;1068.3056013591229;1074.2426589254712;1077.0414331245197;19598.412047638594;19928;20306.289279875135;20317.288894888607;20547.178112875616;1097.204526718123;1116.7040734205443;1118.82658187981;1124.4658787076073;1125.2235957189514;11201.439928003567;11326.943365283121;11371.431428428545;11439.798821123662;11457.19799614019;582813;607271;623568;628386;642359;131111;132406;134038;135742;137317;1111.6164923101517;1163.069544364522;1221.908356873238;1237.4864431260926;1286.12543470441;20830.89584552128;21006.62990025329;21090.261840835497;21436.892815535823;21446.78553214448;63930.68034659797;64998.67500662467;65046.34953650403;65085;67919.3208067913;82235;84035.57982210294;84091;84343.5782821082;85255;20879.582408352053;21353.25263615766;21411.78588214098;21551.8922405387;21582.2734181262;24395.51208975846;24405;24728.25815225546;24938.875305623355;24940.501189975737;19936;19958.800411995693;20032.399028029184;20070.698939516213;20138.69791953151;16730.665386691955;17250.482485525456;17445.651086978443;17973.460796176136;18021.369252076114;19176.328828491492;20382.18471261192;20511.17955281772;20547.8972605136;20665.483362916046;20889.164433423102;21044.894775526023;21181.258655946967;21231.893840530698;21240.044198011437;19827.702584461535;20026.299079532146;20113.899430502755;20128;20206.494837629176 06:06:07 INFO - PID 12696 | |3;mootools.html;1405.3886559346683;1455.6579203887088;1472.2712257432572;1478.0762023735158;1493.0668332292316;16881.915590422046;17656.911715441405;17660.38188663397;17666.73499897501;17674.646507069883;17120.400785972495;17271.39550115746;17278.481645550655;17291.13544322782;17296.827031729677;2652.8540930248923;2659.601059841025;2707.756301932826;2713.4980028694754;2720.1567514070603;2629.894804207839;2652.2308530526125;2683.6645419322585;2686.4895669822768;2688.8252263602803;2408.2654790288957;2506.310764539757;2584.922452326424;2588.314096764359;2630.053180854891;2691.111933062085;2706.6616672915884;2722.7005029446746;2734.4941185880675;2737.5209338365707;2348.917787877433;2568.678915135608;2660.428007978294;2661.7072122066556;2681.142034548945;16611.41860034893;16735.748963765553;16756.413525526546;16762.413315533897;16997.57506062346;8195.83608327836;8436.662533498653;8448.662053517852;8454.915450845474;8536.8719469208;5281.36623605166;5487.6158668892795;5581.302337207849;5608.747606357723;5659.773609055633;2126.0964090261577;2147.194801949269;2151.4621344663833;2156.7196264485515;2209.2215766308113;30505.542416863766;30595.2351191222;30622.69377306221;30759.53860692069;30810.84594577035;6662.6668666566475;6736.157980252468;6750.696218670171;6861.348171923659;6872.278410766798;19209.423717288504;19247.90376048111;19346.613067738566;19354.225830966887;19389.612207755767;8079.313258373104;8255.917440825515;8308.086110527836;8337.791555211168;8352.290055345364;7017.649117544204;7590.051243594551;7613.581253031026;7679.19368466303;7680.73117440898;5548.306461692288;5594.1888426177975;5620.269364982526;5662.320521537442;5665.858353541194;1575.4643421236835;1581.810182778074;1585.326236349547;1589.1577463944127;1600.3758534171682;924.713338864954;936.480253459323;942.2509105261333;947.9194268487117;948.6063283737171;8273.172682731678;8283.875741863876;8285.792855178668;8308.792280193044;8364.37267204962;760.2929275773583;787.7872974296907;794.0709370037071;798.2855344466669;1042.0777611813598;5903.2325797646035;6058.697065146725;6086.265414356887;6086.786962456293;6180.876382472416;23588.764112359;25477;25539.744602554107;25584.10455634044;25699.74300257011;24298.14956476515;24822.37944051377;24873.751262487505;25128.623070653954;25254;12171.878281217074;12253.019758419305;12608.432620532098;12664.87335126637;12810.9359453204;9280.303977201871;9507.572159252712;9523.19052880513;9535.332526723063;9583.329166958247;21282.57434851325;21304.786952130282;21313.147474101483;21408.678869816653;21554.568908622052;21797.346079617637;21983.780162198174;22005;22142.889285554113;22343.10627574879;12169.087318450975;12312.199707019015;12467.127301088836;12483.687907802378;12491.312977786309;15391.461298854934;15639.687206255583;15659.921700391425;15682.451114210948;15738.213089345716;11607.709807254887;11710.531578736754;11814.94092529532;11851.288922664668;12106.394680266128;11323.377214252965;11427.257228280136;11452.82820757706;11646.359450230319;11825.349605771766;10003.649872254437;10144.137748291478;10160.949195253976;10170.237232207466;10178.389296642225;8117.8376432472205;8197.385196110195;8255.215754503313;8332.083470818085;8339.874901876598;8266.090730019814;8352;8369.079401265733;8418.410711250153;8472.068072512142 06:06:07 INFO - PID 12696 | |4;prototype.html;553.8670719027434;557.2532806039907;566.3628418029716;583.6993948116718;588.5732843688323;6102.230353197573;6144.109104179891;6229.377062293768;6344.429001389874;6369.904451433232;6215.254169499655;6239.064140378945;6243.250809902806;6273.905891411632;6280.120783090371;5126.282320475137;5130.666506677054;5143.305653736735;5187.922181167267;5205.7397130143345;4893.140606569498;4955.256711493269;4978.576820970222;4990.825321113762;5143.639945203838;4902.8038878444995;4932.728699921503;4962.154330393938;4970.602351811846;4976.527229913152;4884.511548845105;4896.43690975537;4914.63140264478;4927.852164435073;4934.25986102084;4464.129494748526;4482;4508.661850361236;4546.136234115507;4558.703684260546;6168.290646575656;6195.628262304276;6207.199912025507;6209.5032397408095;6235.625862448268;5713.657180569137;5750.607141786324;5858.8242352729485;5879.8530036749;5895.675737834417;6407.71165297558;6522.782254033604;6523.836904077389;6527.902081468782;6552.901706474407;4798.5441383068555;4965.950340496585;4981.4308492825;4982.476839931827;5022.522860328263;6787.524873258873;6787.898181527281;6800.217974932847;6846.7945961621235;6883.827904302432;5078;5144.768485418165;5152.716600587004;5159.7678104485385;5171;5183.377994640592;5190.92213616796;5193.091209038404;5200;5249.632525723239;5701.287339082614;5735.369109397963;5763.452472015236;5773.88452230953;5806.535477161817;6554.246261679968;6639.3692599203;6641.269460359356;6647.800565983028;6670.199576050905;1786.7677201963922;1788.534980904974;1795.3357257814691;1811.1397086383863;1812.7099664053687;1208.8395140664884;1272.4210484229654;1290.2838924396863;1293.715382615823;1301.73965206959;6059.333473317932;6070.848228794315;6075.149479072933;6086.72178842448;6110.7861224856915;6566.967165164239;6586.80239592813;6626.801195964129;6690.765823196165;6736.393724564813;5830.679312637845;5895.557833162444;5995.800839832051;6007.969960150172;6020.187274717945;3490.965090349064;3517.8592856285463;3545.982270088633;3548.6806187443253;3554.537910071674;6772.72909083641;6839.487038472134;6846;6863.759768408082;6979.8604027919155;6922.238553759083;6933.5493192942295;6937;6963.338482844122;6992.168171890393;6925.58446493212;6959.164900212007;6959.582425054513;6974.455308030128;7001.92998070023;6687.164104486939;6687.799366019027;6696.229933557704;6703.899441508283;6715;6679.599224046573;6700.597964122168;6708.262091170065;6747.325267473213;6747.561408508432;6812.82967925786;6925.926481395391;6928.896066559107;6965.930340696528;6970.965145174445;5070.771815268248;5111.769970351269;5120.692758434357;5129.153689641316;5162.457941916045;6552.803415897531;6589.934100659124;6691.397774200345;6694.59832410057;6768.187817461936;6404.487640988803;6417.743290268337;6439.67801609927;6470.870582588228;6511.2512061113575;6411.551191416556;6433.324500927335;6449.677516124269;6453.51598630114;6552.1154644124335;6379.362063793584;6398.232212134388;6433.195850518685;6500.837479063061;6544.509161812788;6492.935070649233;6532.673366331759;6568.80293591193;6578.440832529097;6654.534182607171;6246.3753624637175;6410.423061924263;6430.3891130342545;6432.099506069248;6451.580647257913 06:06:07 INFO - PID 12696 | |5;yui.html;976.7558110472382;977.2377545514502;984.7882705218378;990.1979396688678;997.2171845101592;20588.1764729411;20786.688199677;20965.685514717272;21366.679499807517;21406.036728347222;18165.182566784493;18216.180271887763;18336.816631833677;18343.724844127315;18343.816561834377;1030.4435604773432;1054.7152268887396;1055.7993981143597;1056.978860422795;1057.148995058977;1047.1256500821785;1055.9736006599858;1061.6549621373047;1062.617457715222;1067.7117178361837;1084.7938891610568;1121.4785124916912;1121.8822023687517;1122.259308856155;1127.61661035248;1115.336374856963;1116.2967330581723;1116.5868628607386;1117.0560876059717;1117.201201141188;795.5226863881683;815.7675062607187;819.2708489444399;819.5779173725537;823.3084209264247;21379.8931005344;21554.137834486603;21582.136714531556;21596.352109436742;21604.243851465122;23341.53316933652;24064.518709625885;24211.273661790176;24420.877895610585;24424;18688.532786680305;18923.526911827175;18996.145173467226;19095.713564296548;19129.904350478297;4037.2531081749676;4065.7357271777537;4070.959290407088;4071.1654110907193;4073.959260407388;135377;157527;157695.2115239428;160362;161566.99999999884;18685.439436816916;19070.713939290923;19208.71186932197;19276.036198190035;19316.71024934627;34541.481877771854;34743.30513389718;34963.65036349655;35083.64916350855;35138.47292290618;9722.756931076638;9761.755956101013;9791.069848364394;9809;9819.36174148678;4394.209042372404;4400.603945644907;4445.82216711328;4463.375127482155;4485.775711214492;6068.75724971005;6175.289841668266;6184.072389141665;6198.81403557894;6225.221847269091;1135.7444574970566;1164.9708757281135;1177.8292147638545;1179.1922533064878;1180.3626041937257;725.6117976882342;735.2647352647352;738.8485360501085;754.4756394306014;774.2257742257742;13325.267110308832;13581.86418135806;13584.388702508411;13976.650583735285;14049.71900561983;730.3572855886786;730.9488335816442;736.9926300737031;747.7196051480695;748.5770539645083;5979.282486101695;6020.488258497989;6045.123457098696;6069.605475644069;6178.104174894615;144964.27517862554;145471;146822;147259;155943;102608.48695756473;103507.4824625872;125365.37317313538;134551;141912;107150;111860;114092.42953785179;115438.99999999833;119844;13942.512012079529;14125.929370353493;14160.221187834768;14211.857881421054;14650.780238296222;54552.18171727507;54797.45202547924;55676.72161639166;55907;55934.72032639811;71906.28093718996;72172;72903.27096728965;73239.63380183066;73282.26717732755;19195.424137275902;19816.801831981495;19842.107105180592;19864.50338741543;19871.900640496704;23513.88243058774;23793.405164871016;23917.28248152558;23973.880130599933;24125.03499859986;21759;21788.237411690516;22044.33866983993;22281.777182227972;22332.441688957257;19118.617627647647;19332.130054147878;19346.4196074118;19482.318118865773;19524.121414536097;19480.51298717487;21116.47208819792;21611.783882160977;22001.339959801233;22522.21172258963;15634.218289085728;15760.527184184493;15858.207089645703;15885.920570397075;15955.680886382439;15501.84498155004;15843.287052082915;15926.283317250984;15926.681466370375;16180.433684820975 06:06:07 INFO - PID 12696 | __end_tp_report 06:06:07 INFO - PID 12696 | __start_cc_report 06:06:07 INFO - PID 12696 | _x_x_mozilla_cycle_collect,366 06:06:07 INFO - PID 12696 | __end_cc_report 06:06:07 INFO - PID 12696 | __startTimestamp1504789567676__endTimestamp 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | ------- Summary: start ------- 06:06:07 INFO - PID 12696 | Number of tests: 6 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#0] dojo.html Cycles:165 Average:6300.57 Median:6597.00 stddev:887.42 (13.5%) stddev-sans-first:868.72 06:06:07 INFO - PID 12696 | Values: 3830.1 3882.2 3886.7 3894.6 3907.4 6264.5 6335.0 6368.1 6382.4 6454.6 6375.5 6380.1 6398.7 6402.2 6442.8 5687.8 5738.9 5783.5 5792.4 5820.3 5771.5 5782.1 5827.8 5830.4 5855.0 89.6 5642.7 5683.7 5725.1 5820.9 5706.9 5707.5 5786.4 5787.0 5798.2 5701.8 5702.9 5756.5 5765.3 5788.8 6263.1 6337.6 6400.6 6404.9 6424.6 6864.9 6878.6 6939.0 6952.6 6972.3 6839.4 6915.2 6935.9 6991.8 6995.5 6400.1 6428.6 6471.2 6492.9 6517.8 7035.9 7051.2 7094.8 7148.1 7151.5 6667.1 6763.6 6803.3 6815.6 6886.5 6831.8 6835.2 6840.3 6843.8 6887.3 6723.5 6882.9 6889.2 6892.5 6897.4 6823.9 6830.9 6842.3 6923.6 6931.6 4924.1 4974.3 4990.9 5055.5 5057.0 4552.2 4567.5 4644.5 4662.4 4662.6 6290.7 6294.7 6298.9 6374.5 6379.3 6862.1 6868.7 6954.6 6965.8 6969.2 6157.3 6290.8 6295.1 6302.7 6361.5 5426.2 5489.9 5516.1 5569.8 5579.1 7040.4 7042.4 7047.5 7113.5 7119.7 6779.9 6789.7 6864.3 6878.4 6879.9 6950.3 7039.1 7055.5 7057.3 7061.8 6720.6 6760.4 6780.0 6801.8 6825.7 6822.8 6837.6 6933.2 6938.8 6974.5 6618.0 6623.6 6628.8 6703.0 6713.2 6471.1 6580.8 6587.9 6594.1 6597.0 6601.2 6601.6 6667.4 6671.1 6675.7 6682.2 6726.0 6831.1 6834.6 6847.5 6372.3 6506.5 6523.3 6592.6 6612.7 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#1] ext.html Cycles:180 Average:42794.03 Median:3793.52 stddev:63480.36 (1673.4%) stddev-sans-first:63580.55 06:06:07 INFO - PID 12696 | Values: 912.5 923.6 941.2 956.9 962.5 43457.6 43582.8 44345.3 44403.0 44503.6 44821.6 45242.8 45301.0 45630.8 45709.5 8051.8 8242.8 8259.2 8278.0 8287.3 7938.2 8017.5 8019.9 8020.0 8024.2 7991.7 7992.4 8034.8 8044.3 8067.5 7916.0 7964.3 7978.9 8021.5 8032.6 8090.8 8108.8 8117.6 8126.3 8127.1 39806.6 40029.8 40053.2 40177.6 40282.6 3739.1 3786.9 3800.1 3806.3 3807.7 33410.0 33508.8 33516.7 33519.5 33552.8 5389.2 5409.9 5416.5 5426.2 5516.4 217160.0 218121.0 218325.0 219078.0 219593.0 50248.7 50569.0 50718.7 50823.2 50839.0 53833.7 53978.2 54011.5 54040.2 54058.0 14852.0 14960.6 14977.6 14993.0 14998.5 11872.3 11915.9 11944.2 11947.3 11952.4 13908.7 14264.3 14304.9 14305.3 14362.3 5270.4 5288.3 5334.6 5463.6 5475.6 1045.7 1055.8 1074.9 1075.6 1084.1 31846.4 31997.7 32456.0 32559.8 32646.8 1128.2 1140.1 1150.3 1151.1 1153.0 13366.5 13445.0 13648.9 13726.7 17500.7 270770.0 271058.0 271268.0 286934.0 292055.0 61323.7 61337.4 61436.0 61439.0 61674.4 1448.1 1451.6 1454.8 1470.5 1479.6 29454.4 29679.7 29775.3 30405.5 30407.5 39941.2 40019.0 40035.0 40057.0 40144.0 230654.0 230863.0 231642.0 232823.0 233681.0 36469.5 36504.3 36504.5 37142.6 38159.6 49479.0 50077.5 50109.7 50197.2 50600.5 36684.3 36698.3 36755.1 36889.3 37108.8 36176.1 36251.3 36331.6 36388.6 36561.3 42652.4 42654.6 42875.1 43054.0 43099.6 35001.0 35277.0 35469.8 35737.8 35768.3 26153.9 26637.2 27066.5 27227.2 27534.4 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#2] jquery.html Cycles:180 Average:40470.89 Median:24279.38 stddev:103068.85 (424.5%) stddev-sans-first:103314.49 06:06:07 INFO - PID 12696 | Values: 592.7 597.2 600.0 613.2 618.6 23239.3 24201.9 24258.4 24261.9 24296.9 24807.5 25998.0 26103.2 26114.9 26151.0 6620.1 6667.5 6753.8 6755.7 6760.4 6485.7 6615.2 6694.1 6732.4 6739.2 6677.8 6691.3 6691.9 6693.6 6695.8 6678.6 6685.2 6688.7 6691.2 6695.6 6248.4 6255.3 6256.4 6264.6 6279.8 28137.7 29014.1 29120.0 29280.3 29499.0 2203.2 2242.7 2243.7 2243.7 2245.0 20005.5 20269.7 20897.9 20981.3 20985.9 2536.5 2585.3 2589.9 2591.7 2648.5 139504.0 142823.0 143927.3 145440.0 153262.2 16012.7 16180.3 16490.3 16515.5 16576.6 25466.6 25473.4 25499.0 25503.9 25534.2 9483.2 9483.5 9547.2 9585.0 9623.4 8187.9 8248.1 8266.7 8273.8 8324.9 9778.5 9950.9 9989.0 10023.3 10100.3 2906.3 2937.0 2967.2 2976.5 3017.5 1039.3 1051.3 1068.3 1074.2 1077.0 19598.4 19928.0 20306.3 20317.3 20547.2 1097.2 1116.7 1118.8 1124.5 1125.2 11201.4 11326.9 11371.4 11439.8 11457.2 582813.0 607271.0 623568.0 628386.0 642359.0 131111.0 132406.0 134038.0 135742.0 137317.0 1111.6 1163.1 1221.9 1237.5 1286.1 20830.9 21006.6 21090.3 21436.9 21446.8 63930.7 64998.7 65046.3 65085.0 67919.3 82235.0 84035.6 84091.0 84343.6 85255.0 20879.6 21353.3 21411.8 21551.9 21582.3 24395.5 24405.0 24728.3 24938.9 24940.5 19936.0 19958.8 20032.4 20070.7 20138.7 16730.7 17250.5 17445.7 17973.5 18021.4 19176.3 20382.2 20511.2 20547.9 20665.5 20889.2 21044.9 21181.3 21231.9 21240.0 19827.7 20026.3 20113.9 20128.0 20206.5 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#3] mootools.html Cycles:180 Average:10326.51 Median:2586.62 stddev:7783.63 (300.9%) stddev-sans-first:7776.61 06:06:07 INFO - PID 12696 | Values: 1405.4 1455.7 1472.3 1478.1 1493.1 16881.9 17656.9 17660.4 17666.7 17674.6 17120.4 17271.4 17278.5 17291.1 17296.8 2652.9 2659.6 2707.8 2713.5 2720.2 2629.9 2652.2 2683.7 2686.5 2688.8 2408.3 2506.3 2584.9 2588.3 2630.1 2691.1 2706.7 2722.7 2734.5 2737.5 2348.9 2568.7 2660.4 2661.7 2681.1 16611.4 16735.7 16756.4 16762.4 16997.6 8195.8 8436.7 8448.7 8454.9 8536.9 5281.4 5487.6 5581.3 5608.7 5659.8 2126.1 2147.2 2151.5 2156.7 2209.2 30505.5 30595.2 30622.7 30759.5 30810.8 6662.7 6736.2 6750.7 6861.3 6872.3 19209.4 19247.9 19346.6 19354.2 19389.6 8079.3 8255.9 8308.1 8337.8 8352.3 7017.6 7590.1 7613.6 7679.2 7680.7 5548.3 5594.2 5620.3 5662.3 5665.9 1575.5 1581.8 1585.3 1589.2 1600.4 924.7 936.5 942.3 947.9 948.6 8273.2 8283.9 8285.8 8308.8 8364.4 760.3 787.8 794.1 798.3 1042.1 5903.2 6058.7 6086.3 6086.8 6180.9 23588.8 25477.0 25539.7 25584.1 25699.7 24298.1 24822.4 24873.8 25128.6 25254.0 12171.9 12253.0 12608.4 12664.9 12810.9 9280.3 9507.6 9523.2 9535.3 9583.3 21282.6 21304.8 21313.1 21408.7 21554.6 21797.3 21983.8 22005.0 22142.9 22343.1 12169.1 12312.2 12467.1 12483.7 12491.3 15391.5 15639.7 15659.9 15682.5 15738.2 11607.7 11710.5 11814.9 11851.3 12106.4 11323.4 11427.3 11452.8 11646.4 11825.3 10003.6 10144.1 10160.9 10170.2 10178.4 8117.8 8197.4 8255.2 8332.1 8339.9 8266.1 8352.0 8369.1 8418.4 8472.1 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#4] prototype.html Cycles:180 Average:5586.07 Median:6212.38 stddev:1558.13 (25.1%) stddev-sans-first:1516.03 06:06:07 INFO - PID 12696 | Values: 553.9 557.3 566.4 583.7 588.6 6102.2 6144.1 6229.4 6344.4 6369.9 6215.3 6239.1 6243.3 6273.9 6280.1 5126.3 5130.7 5143.3 5187.9 5205.7 4893.1 4955.3 4978.6 4990.8 5143.6 4902.8 4932.7 4962.2 4970.6 4976.5 4884.5 4896.4 4914.6 4927.9 4934.3 4464.1 4482.0 4508.7 4546.1 4558.7 6168.3 6195.6 6207.2 6209.5 6235.6 5713.7 5750.6 5858.8 5879.9 5895.7 6407.7 6522.8 6523.8 6527.9 6552.9 4798.5 4966.0 4981.4 4982.5 5022.5 6787.5 6787.9 6800.2 6846.8 6883.8 5078.0 5144.8 5152.7 5159.8 5171.0 5183.4 5190.9 5193.1 5200.0 5249.6 5701.3 5735.4 5763.5 5773.9 5806.5 6554.2 6639.4 6641.3 6647.8 6670.2 1786.8 1788.5 1795.3 1811.1 1812.7 1208.8 1272.4 1290.3 1293.7 1301.7 6059.3 6070.8 6075.1 6086.7 6110.8 6567.0 6586.8 6626.8 6690.8 6736.4 5830.7 5895.6 5995.8 6008.0 6020.2 3491.0 3517.9 3546.0 3548.7 3554.5 6772.7 6839.5 6846.0 6863.8 6979.9 6922.2 6933.5 6937.0 6963.3 6992.2 6925.6 6959.2 6959.6 6974.5 7001.9 6687.2 6687.8 6696.2 6703.9 6715.0 6679.6 6700.6 6708.3 6747.3 6747.6 6812.8 6925.9 6928.9 6965.9 6971.0 5070.8 5111.8 5120.7 5129.2 5162.5 6552.8 6589.9 6691.4 6694.6 6768.2 6404.5 6417.7 6439.7 6470.9 6511.3 6411.6 6433.3 6449.7 6453.5 6552.1 6379.4 6398.2 6433.2 6500.8 6544.5 6492.9 6532.7 6568.8 6578.4 6654.5 6246.4 6410.4 6430.4 6432.1 6451.6 06:06:07 INFO - PID 12696 | 06:06:07 INFO - PID 12696 | [#5] yui.html Cycles:180 Average:28586.20 Median:20230.04 stddev:40930.21 (202.3%) stddev-sans-first:40992.53 06:06:07 INFO - PID 12696 | Values: 976.8 977.2 984.8 990.2 997.2 20588.2 20786.7 20965.7 21366.7 21406.0 18165.2 18216.2 18336.8 18343.7 18343.8 1030.4 1054.7 1055.8 1057.0 1057.1 1047.1 1056.0 1061.7 1062.6 1067.7 1084.8 1121.5 1121.9 1122.3 1127.6 1115.3 1116.3 1116.6 1117.1 1117.2 795.5 815.8 819.3 819.6 823.3 21379.9 21554.1 21582.1 21596.4 21604.2 23341.5 24064.5 24211.3 24420.9 24424.0 18688.5 18923.5 18996.1 19095.7 19129.9 4037.3 4065.7 4071.0 4071.2 4074.0 135377.0 157527.0 157695.2 160362.0 161567.0 18685.4 19070.7 19208.7 19276.0 19316.7 34541.5 34743.3 34963.7 35083.6 35138.5 9722.8 9761.8 9791.1 9809.0 9819.4 4394.2 4400.6 4445.8 4463.4 4485.8 6068.8 6175.3 6184.1 6198.8 6225.2 1135.7 1165.0 1177.8 1179.2 1180.4 725.6 735.3 738.8 754.5 774.2 13325.3 13581.9 13584.4 13976.7 14049.7 730.4 730.9 737.0 747.7 748.6 5979.3 6020.5 6045.1 6069.6 6178.1 144964.3 145471.0 146822.0 147259.0 155943.0 102608.5 103507.5 125365.4 134551.0 141912.0 107150.0 111860.0 114092.4 115439.0 119844.0 13942.5 14125.9 14160.2 14211.9 14650.8 54552.2 54797.5 55676.7 55907.0 55934.7 71906.3 72172.0 72903.3 73239.6 73282.3 19195.4 19816.8 19842.1 19864.5 19871.9 23513.9 23793.4 23917.3 23973.9 24125.0 21759.0 21788.2 22044.3 22281.8 22332.4 19118.6 19332.1 19346.4 19482.3 19524.1 19480.5 21116.5 21611.8 22001.3 22522.2 15634.2 15760.5 15858.2 15885.9 15955.7 15501.8 15843.3 15926.3 15926.7 16180.4 06:06:07 INFO - PID 12696 | -------- Summary: end -------- 06:06:07 INFO - PID 12696 | 06:06:08 INFO - TEST-INFO | 12696: exit 0 06:06:08 INFO - TEST-OK | dromaeo_css | took 1108048ms 06:06:08 INFO - TEST-START | kraken 06:06:08 INFO - Initialising browser for kraken test... 06:06:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38675/getInfo.html -profile /tmp/tmpEzrIvz/profile 06:06:08 INFO - TEST-INFO | started process 13087 (/builds/slave/test/build/application/firefox/firefox http://localhost:38675/getInfo.html) 06:06:13 INFO - TEST-INFO | 13087: exit 0 06:06:14 INFO - Browser initialized. 06:06:14 INFO - Running cycle 1/1 for kraken test... 06:06:14 INFO - Using env: {'DISPLAY': ':0', 06:06:14 INFO - 'HOME': '/home/cltbld', 06:06:14 INFO - 'JSGC_DISABLE_POISONING': '1', 06:06:14 INFO - 'LANG': 'en_US.UTF-8', 06:06:14 INFO - 'LANGUAGE': 'en_US:en', 06:06:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:06:14 INFO - 'LOGNAME': 'cltbld', 06:06:14 INFO - 'MAIL': '/var/mail/cltbld', 06:06:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:06:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:06:14 INFO - 'MOZ_CRASHREPORTER': '1', 06:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:06:14 INFO - 'MOZ_NO_REMOTE': '1', 06:06:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:14 INFO - 'NO_EM_RESTART': '1', 06:06:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:14 INFO - 'PWD': '/builds/slave/test', 06:06:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:06:14 INFO - 'RUST_BACKTRACE': 'full', 06:06:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:06:14 INFO - 'SHELL': '/bin/bash', 06:06:14 INFO - 'SHLVL': '1', 06:06:14 INFO - 'TERM': 'linux', 06:06:14 INFO - 'TMOUT': '86400', 06:06:14 INFO - 'USER': 'cltbld', 06:06:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913', 06:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:14 INFO - '_': '/tools/buildbot/bin/python'} 06:06:14 INFO - TEST-INFO | started process 13290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzrIvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:14 INFO - PID 13290 | 06:06:14 INFO - PID 13290 | (/builds/slave/test/build/application/firefox/firefox:13340): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:06:14 INFO - PID 13290 | 06:06:25 INFO - PID 13290 | RSS: Main: 164241408 06:06:25 INFO - PID 13290 | 06:06:27 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38675/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:28 INFO - PID 13290 | RSS: Main: 169775104 06:06:28 INFO - PID 13290 | 06:06:31 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38675/tests/kraken/driver.html?testName=audio-dft) 06:06:31 INFO - PID 13290 | RSS: Main: 170647552 06:06:31 INFO - PID 13290 | 06:06:34 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38675/tests/kraken/driver.html?testName=audio-fft) 06:06:35 INFO - PID 13290 | RSS: Main: 164503552 06:06:35 INFO - PID 13290 | 06:06:37 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38675/tests/kraken/driver.html?testName=audio-oscillator) 06:06:38 INFO - PID 13290 | RSS: Main: 166027264 06:06:38 INFO - PID 13290 | 06:06:40 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:40 INFO - PID 13290 | RSS: Main: 165785600 06:06:40 INFO - PID 13290 | 06:06:43 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38675/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:44 INFO - PID 13290 | RSS: Main: 169279488 06:06:44 INFO - PID 13290 | 06:06:48 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38675/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:48 INFO - PID 13290 | RSS: Main: 168542208 06:06:48 INFO - PID 13290 | 06:06:51 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38675/tests/kraken/driver.html?testName=json-parse-financial) 06:06:52 INFO - PID 13290 | RSS: Main: 169070592 06:06:52 INFO - PID 13290 | 06:06:53 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:54 INFO - PID 13290 | RSS: Main: 168681472 06:06:54 INFO - PID 13290 | 06:06:55 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:56 INFO - PID 13290 | RSS: Main: 168833024 06:06:56 INFO - PID 13290 | 06:06:58 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:59 INFO - PID 13290 | RSS: Main: 165953536 06:06:59 INFO - PID 13290 | 06:07:01 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:02 INFO - PID 13290 | RSS: Main: 166195200 06:07:02 INFO - PID 13290 | 06:07:05 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:05 INFO - PID 13290 | RSS: Main: 166506496 06:07:05 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | Cycle 1(1): loaded http://localhost:38675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38675/tests/kraken/driver.html?testName=ai-astar) 06:07:07 INFO - PID 13290 | RSS: Main: 168140800 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | __start_tp_report 06:07:07 INFO - PID 13290 | _x_x_mozilla_page_load 06:07:07 INFO - PID 13290 | _x_x_mozilla_page_load_details 06:07:07 INFO - PID 13290 | |i|pagename|runs| 06:07:07 INFO - PID 13290 | |0;ai-astar;107;108;106;106;107;108;109;106;96;105 06:07:07 INFO - PID 13290 | |1;audio-beat-detection;115;115;113;116;115;113;112;141;114;138 06:07:07 INFO - PID 13290 | |2;audio-dft;164;163;165;161;161;161;162;163;163;164 06:07:07 INFO - PID 13290 | |3;audio-fft;73;72;73;73;73;73;73;73;73;73 06:07:07 INFO - PID 13290 | |4;audio-oscillator;80;78;78;77;83;83;86;77;78;77 06:07:07 INFO - PID 13290 | |5;imaging-gaussian-blur;114;113;114;114;111;114;113;114;113;113 06:07:07 INFO - PID 13290 | |6;imaging-darkroom;149;150;149;149;150;150;150;150;150;150 06:07:07 INFO - PID 13290 | |7;imaging-desaturate;94;93;94;99;93;99;98;99;98;99 06:07:07 INFO - PID 13290 | |8;json-parse-financial;44;44;44;46;43;44;44;46;42;43 06:07:07 INFO - PID 13290 | |9;json-stringify-tinderbox;39;39;39;38;39;39;40;38;39;39 06:07:07 INFO - PID 13290 | |10;stanford-crypto-aes;75;74;77;73;71;73;71;72;72;72 06:07:07 INFO - PID 13290 | |11;stanford-crypto-ccm;116;124;113;117;110;108;113;112;111;112 06:07:07 INFO - PID 13290 | |12;stanford-crypto-pbkdf2;159;157;155;159;155;162;163;156;166;155 06:07:07 INFO - PID 13290 | |13;stanford-crypto-sha256-iterative;68;60;65;69;60;57;58;59;60;63 06:07:07 INFO - PID 13290 | __end_tp_report 06:07:07 INFO - PID 13290 | __start_cc_report 06:07:07 INFO - PID 13290 | _x_x_mozilla_cycle_collect,913 06:07:07 INFO - PID 13290 | __end_cc_report 06:07:07 INFO - PID 13290 | __startTimestamp1504789627744__endTimestamp 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | ------- Summary: start ------- 06:07:07 INFO - PID 13290 | Number of tests: 14 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#0] ai-astar Cycles:10 Average:105.80 Median:107.50 stddev:3.65 (3.4%) stddev-sans-first:3.84 06:07:07 INFO - PID 13290 | Values: 107.0 108.0 106.0 106.0 107.0 108.0 109.0 106.0 96.0 105.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:115.00 stddev:10.79 (9.4%) stddev-sans-first:11.34 06:07:07 INFO - PID 13290 | Values: 115.0 115.0 113.0 116.0 115.0 113.0 112.0 141.0 114.0 138.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.42 (0.9%) stddev-sans-first:1.42 06:07:07 INFO - PID 13290 | Values: 164.0 163.0 165.0 161.0 161.0 161.0 162.0 163.0 163.0 164.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:07:07 INFO - PID 13290 | Values: 73.0 72.0 73.0 73.0 73.0 73.0 73.0 73.0 73.0 73.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:79.00 stddev:3.20 (4.0%) stddev-sans-first:3.39 06:07:07 INFO - PID 13290 | Values: 80.0 78.0 78.0 77.0 83.0 83.0 86.0 77.0 78.0 77.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 06:07:07 INFO - PID 13290 | Values: 114.0 113.0 114.0 114.0 111.0 114.0 113.0 114.0 113.0 113.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:07:07 INFO - PID 13290 | Values: 149.0 150.0 149.0 149.0 150.0 150.0 150.0 150.0 150.0 150.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:98.50 stddev:2.72 (2.8%) stddev-sans-first:2.71 06:07:07 INFO - PID 13290 | Values: 94.0 93.0 94.0 99.0 93.0 99.0 98.0 99.0 98.0 99.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#8] json-parse-financial Cycles:10 Average:44.00 Median:44.00 stddev:1.25 (2.8%) stddev-sans-first:1.32 06:07:07 INFO - PID 13290 | Values: 44.0 44.0 44.0 46.0 43.0 44.0 44.0 46.0 42.0 43.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 06:07:07 INFO - PID 13290 | Values: 39.0 39.0 39.0 38.0 39.0 39.0 40.0 38.0 39.0 39.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:1.89 (2.6%) stddev-sans-first:1.86 06:07:07 INFO - PID 13290 | Values: 75.0 74.0 77.0 73.0 71.0 73.0 71.0 72.0 72.0 72.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:4.69 06:07:07 INFO - PID 13290 | Values: 116.0 124.0 113.0 117.0 110.0 108.0 113.0 112.0 111.0 112.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:3.86 (2.4%) stddev-sans-first:4.09 06:07:07 INFO - PID 13290 | Values: 159.0 157.0 155.0 159.0 155.0 162.0 163.0 156.0 166.0 155.0 06:07:07 INFO - PID 13290 | 06:07:07 INFO - PID 13290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:4.18 (6.8%) stddev-sans-first:3.80 06:07:07 INFO - PID 13290 | Values: 68.0 60.0 65.0 69.0 60.0 57.0 58.0 59.0 60.0 63.0 06:07:07 INFO - PID 13290 | -------- Summary: end -------- 06:07:07 INFO - PID 13290 | 06:07:08 INFO - PID 13290 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:07:08 INFO - TEST-INFO | 13290: exit 0 06:07:08 INFO - TEST-OK | kraken | took 60058ms 06:07:08 INFO - SUITE-END | took 1168s 06:07:08 INFO - Completed test suite (00:19:28) 06:07:08 INFO - javascript benchmark 06:07:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9113.334422851309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3830.0999265172663, 3882.184741204347, 3886.708496862735, 3894.5715971243158, 3907.4138879168104, 6264.530160237978, 6335.0, 6368.076628888808, 6382.393672601102, 6454.612723236609, 6375.4899608031365, 6380.138681278037, 6398.712057957391, 6402.16771819664, 6442.838929026777, 5687.772489100431, 5738.942610573903, 5783.5084017858535, 5792.4497172768515, 5820.272465941757, 5771.538276937856, 5782.074868021117, 5827.825165245049, 5830.387809280028, 5854.970725146369, 89.61228212152251, 5642.661440313574, 5683.744231509592, 5725.083986562172, 5820.941790582082, 5706.885862282731, 5707.543396528268, 5786.363500014995, 5787.0, 5798.246227990377, 5701.800436984686, 5702.857428564277, 5756.453136952025, 5765.250517432749, 5788.826335209908, 6263.123162757218, 6337.6197428154, 6400.615963042233, 6404.935950640527, 6424.614523128581, 6864.897026544606, 6878.621675807829, 6939.028536004963, 6952.582845029315, 6972.267911869231, 6839.384455398988, 6915.239323674392, 6935.930640693629, 6991.755288564876, 6995.475339349518, 6400.0719895614875, 6428.550001499897, 6471.191101112361, 6492.902606460907, 6517.837054073639, 7035.859282814315, 7051.1891132519395, 7094.822629434306, 7148.106486689164, 7151.499395042297, 6667.099941507834, 6763.560368576027, 6803.251642319341, 6815.625140617214, 6886.48351373649, 6831.795046148623, 6835.179778426621, 6840.31596840322, 6843.7604683835825, 6887.276835932155, 6723.529352945345, 6882.8967565486555, 6889.173299204128, 6892.517523773388, 6897.41371983377, 6823.93176068233, 6830.94120411337, 6842.349976752201, 6923.6192009438955, 6931.618760968196, 4924.0890435268875, 4974.253861920741, 4990.850274491771, 5055.494450554915, 5056.974715126401, 4552.180607490617, 4567.474740404829, 4644.535546445329, 4662.417197850269, 4662.557057079572, 6290.6789574189015, 6294.685265736694, 6298.874022519615, 6374.458171055419, 6379.298277189506, 6862.073620061228, 6868.656567171622, 6954.582725036514, 6965.756198533129, 6969.16370035599, 6157.291911430243, 6290.811275661737, 6295.118683384329, 6302.747890084437, 6361.491080713532, 5426.158945363475, 5489.890202195934, 5516.062269414209, 5569.832905012856, 5579.107342825128, 7040.436765058783, 7042.436605071582, 7047.471439642048, 7113.502054856214, 7119.679614417364, 6779.86440271182, 6789.72841086351, 6864.313568643096, 6878.449724022066, 6879.931200687929, 6950.3049695030095, 7039.084918960707, 7055.470839686941, 7057.294270572902, 7061.788146355618, 6720.596764194164, 6760.357766012221, 6779.966100169468, 6801.761938332134, 6825.658717064226, 6822.829429264308, 6837.62393068386, 6933.168019837652, 6938.826529336807, 6974.546654467444, 6618.0, 6623.635700036544, 6628.834279142867, 6702.966485167543, 6713.227978782503, 6471.126397936218, 6580.782555227298, 6587.934120658732, 6594.10979517759, 6597.0, 6601.240857301472, 6601.570897891622, 6667.399934005963, 6671.132752742113, 6675.666216689243, 6682.198136223684, 6726.024726414545, 6831.077804496329, 6834.589924604539, 6847.48643851723, 6372.267189273108, 6506.512011599054, 6523.3150519194805, 6592.571482853599, 6612.702428390638], "value": 6242.733845421754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.5482885971445, 923.5751554285029, 941.2234906202384, 956.9186619137373, 962.4946902875989, 43457.56542434578, 43582.7820860896, 44345.334819977725, 44403.0, 44503.55496445035, 44821.551784482144, 45242.77378613102, 45301.0, 45630.77184614072, 45709.542904570946, 8051.758447246577, 8242.793930151764, 8259.21537453941, 8277.95861020694, 8287.337013038972, 7938.206179382045, 8017.478863873829, 8019.919800801976, 8019.95990020052, 8024.2376974187655, 7991.680332786682, 7992.440529162961, 8034.758957231293, 8044.316233120192, 8067.515949043076, 7915.960420197891, 7964.283214510693, 7978.920210797875, 8021.518708877456, 8032.598370081531, 8090.838183236361, 8108.75673729789, 8117.59412029402, 8126.268635822746, 8127.065387480457, 39806.60193398087, 40029.79985100085, 40053.19893602141, 40177.598224017675, 40282.597174028175, 3739.139997800521, 3786.8863934082024, 3800.1449673823445, 3806.3148633246005, 3807.7144214184045, 33410.0, 33508.83245583781, 33516.6648333516, 33519.49720754191, 33552.83223583891, 5389.164679474648, 5409.864753381157, 5416.458354164592, 5426.158945363475, 5516.393196748354, 217160.0, 218121.0, 218325.0, 219078.0, 219592.9999999984, 50248.74875625598, 50569.0, 50718.746406268474, 50823.23765143526, 50839.0, 53833.730831345594, 53978.19032714512, 54011.45988540064, 54040.189397159076, 54058.0, 14852.0, 14960.551183464513, 14977.550673479813, 14993.025453345497, 14998.47505337308, 11872.287662740264, 11915.940420297842, 11944.16390852632, 11947.342896140623, 11952.40237988097, 13908.721825563433, 14264.286785660675, 14304.856951430353, 14305.284735763378, 14362.281885905662, 5270.446603106619, 5288.286081378965, 5334.59990500714, 5463.562914966793, 5475.589330800206, 1045.6813360819917, 1055.8205105131992, 1074.9462526873624, 1075.5694925748735, 1084.1001968366238, 31846.363072738415, 31997.68002319947, 32456.02631921046, 32559.837200813843, 32646.83676581602, 1128.1595211567435, 1140.0822338017974, 1150.2810743285447, 1151.090638395675, 1153.037213926381, 13366.465341386236, 13445.0, 13648.863511364958, 13726.725465490634, 17500.737488937677, 270770.0, 271058.0, 271268.0, 286934.0, 292055.0, 61323.69338153281, 61337.386626133164, 61436.0, 61439.0, 61674.38325616776, 1448.0659974316718, 1451.637090727318, 1454.8036015138032, 1470.5147301390516, 1479.5931118942162, 29454.410911781215, 29679.703202967696, 29775.255618609706, 30405.543916840823, 30407.54388684127, 39941.20117597574, 40019.0, 40035.0, 40057.0, 40143.99999999883, 230654.0, 230863.0, 231642.0, 232823.0, 233681.0, 36469.45295820512, 36504.26218033605, 36504.45243321406, 37142.62857371392, 38159.61840381672, 49479.0, 50077.49922500728, 50109.74945125251, 50197.24704129368, 50600.49399505958, 36684.26631467409, 36698.26603467862, 36755.08112297214, 36889.26221475609, 37108.81445592863, 36176.09559761027, 36251.27497450089, 36331.636683633886, 36388.636113639586, 36561.26877462489, 42652.36021459743, 42654.57345426506, 42875.142497150504, 43054.0, 43099.56900430955, 35001.0, 35277.0, 35469.82265088658, 35737.821310893276, 35768.28463430769, 26153.869230653723, 26637.200883973514, 27066.458670826865, 27227.183184504498, 27534.44931101407], "value": 18670.00793115732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6621825559433, 597.166952101818, 599.961002534835, 613.2089604410311, 618.6102755264183, 23239.302820915356, 24201.91091400887, 24258.393540161505, 24261.87869060652, 24296.87851560744, 24807.503849922992, 25998.0, 26103.216903492877, 26114.869425652843, 26151.0, 6620.139381880349, 6667.466602671775, 6753.763618273361, 6755.729770809162, 6760.3577660122455, 6485.675716214194, 6615.206175258975, 6694.129763130786, 6732.394084532416, 6739.157605299338, 6677.766278180265, 6691.26396096429, 6691.933080669204, 6693.564918280296, 6695.832604184886, 6678.56589321695, 6685.231198412196, 6688.699008544627, 6691.197056353269, 6695.598264104169, 6248.406401391906, 6255.343188965138, 6256.405641464099, 6264.624122552661, 6279.811605651837, 28137.718622813714, 29014.12957611275, 29120.0, 29280.267993300124, 29499.0, 2203.2178576605234, 2242.686023956631, 2243.663450482424, 2243.6858839762444, 2244.9887750561143, 20005.49986250341, 20269.695954560695, 20897.89551052235, 20981.265655701976, 20985.8950705247, 2536.518061568296, 2585.276122685651, 2589.8834552445187, 2591.676040494938, 2648.4835457085874, 139504.0, 142823.0, 143927.28036359855, 145440.0, 153262.23368883197, 16012.679746405007, 16180.271887765079, 16490.257938392562, 16515.504534863972, 16576.585585360222, 25466.618000730003, 25473.363165921, 25499.0, 25503.87248063785, 25534.23397298084, 9483.241340692728, 9483.478408687588, 9547.188488978514, 9584.952075239578, 9623.422594644344, 8187.877181842158, 8248.092709801916, 8266.669333226724, 8273.751787446266, 8324.916750832414, 9778.462184579774, 9950.900490994998, 9989.0, 10023.298369114093, 10100.343477673927, 2906.3170155013554, 2936.9706302936697, 2967.169192626025, 2976.4939960206816, 3017.4719424100695, 1039.2880876599554, 1051.2903789941759, 1068.3056013591229, 1074.2426589254712, 1077.0414331245197, 19598.412047638594, 19928.0, 20306.289279875135, 20317.288894888607, 20547.178112875616, 1097.204526718123, 1116.7040734205443, 1118.82658187981, 1124.4658787076073, 1125.2235957189514, 11201.439928003567, 11326.943365283121, 11371.431428428545, 11439.798821123662, 11457.19799614019, 582813.0, 607271.0, 623568.0, 628386.0, 642359.0, 131111.0, 132406.0, 134038.0, 135742.0, 137317.0, 1111.6164923101517, 1163.069544364522, 1221.908356873238, 1237.4864431260926, 1286.12543470441, 20830.89584552128, 21006.62990025329, 21090.261840835497, 21436.892815535823, 21446.78553214448, 63930.68034659797, 64998.67500662467, 65046.34953650403, 65085.0, 67919.3208067913, 82235.0, 84035.57982210294, 84091.0, 84343.5782821082, 85255.0, 20879.582408352053, 21353.25263615766, 21411.78588214098, 21551.8922405387, 21582.2734181262, 24395.51208975846, 24405.0, 24728.25815225546, 24938.875305623355, 24940.501189975737, 19936.0, 19958.800411995693, 20032.399028029184, 20070.698939516213, 20138.69791953151, 16730.665386691955, 17250.482485525456, 17445.651086978443, 17973.460796176136, 18021.369252076114, 19176.328828491492, 20382.18471261192, 20511.17955281772, 20547.8972605136, 20665.483362916046, 20889.164433423102, 21044.894775526023, 21181.258655946967, 21231.893840530698, 21240.044198011437, 19827.702584461535, 20026.299079532146, 20113.899430502755, 20128.0, 20206.494837629176], "value": 12964.05061465159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.3886559346683, 1455.6579203887088, 1472.2712257432572, 1478.0762023735158, 1493.0668332292316, 16881.915590422046, 17656.911715441405, 17660.38188663397, 17666.73499897501, 17674.646507069883, 17120.400785972495, 17271.39550115746, 17278.481645550655, 17291.13544322782, 17296.827031729677, 2652.8540930248923, 2659.601059841025, 2707.756301932826, 2713.4980028694754, 2720.1567514070603, 2629.894804207839, 2652.2308530526125, 2683.6645419322585, 2686.4895669822768, 2688.8252263602803, 2408.2654790288957, 2506.310764539757, 2584.922452326424, 2588.314096764359, 2630.053180854891, 2691.111933062085, 2706.6616672915884, 2722.7005029446746, 2734.4941185880675, 2737.5209338365707, 2348.917787877433, 2568.678915135608, 2660.428007978294, 2661.7072122066556, 2681.142034548945, 16611.41860034893, 16735.748963765553, 16756.413525526546, 16762.413315533897, 16997.57506062346, 8195.83608327836, 8436.662533498653, 8448.662053517852, 8454.915450845474, 8536.8719469208, 5281.36623605166, 5487.6158668892795, 5581.302337207849, 5608.747606357723, 5659.773609055633, 2126.0964090261577, 2147.194801949269, 2151.4621344663833, 2156.7196264485515, 2209.2215766308113, 30505.542416863766, 30595.2351191222, 30622.69377306221, 30759.53860692069, 30810.84594577035, 6662.6668666566475, 6736.157980252468, 6750.696218670171, 6861.348171923659, 6872.278410766798, 19209.423717288504, 19247.90376048111, 19346.613067738566, 19354.225830966887, 19389.612207755767, 8079.313258373104, 8255.917440825515, 8308.086110527836, 8337.791555211168, 8352.290055345364, 7017.649117544204, 7590.051243594551, 7613.581253031026, 7679.19368466303, 7680.73117440898, 5548.306461692288, 5594.1888426177975, 5620.269364982526, 5662.320521537442, 5665.858353541194, 1575.4643421236835, 1581.810182778074, 1585.326236349547, 1589.1577463944127, 1600.3758534171682, 924.713338864954, 936.480253459323, 942.2509105261333, 947.9194268487117, 948.6063283737171, 8273.172682731678, 8283.875741863876, 8285.792855178668, 8308.792280193044, 8364.37267204962, 760.2929275773583, 787.7872974296907, 794.0709370037071, 798.2855344466669, 1042.0777611813598, 5903.2325797646035, 6058.697065146725, 6086.265414356887, 6086.786962456293, 6180.876382472416, 23588.764112359, 25477.0, 25539.744602554107, 25584.10455634044, 25699.74300257011, 24298.14956476515, 24822.37944051377, 24873.751262487505, 25128.623070653954, 25254.0, 12171.878281217074, 12253.019758419305, 12608.432620532098, 12664.87335126637, 12810.9359453204, 9280.303977201871, 9507.572159252712, 9523.19052880513, 9535.332526723063, 9583.329166958247, 21282.57434851325, 21304.786952130282, 21313.147474101483, 21408.678869816653, 21554.568908622052, 21797.346079617637, 21983.780162198174, 22005.0, 22142.889285554113, 22343.10627574879, 12169.087318450975, 12312.199707019015, 12467.127301088836, 12483.687907802378, 12491.312977786309, 15391.461298854934, 15639.687206255583, 15659.921700391425, 15682.451114210948, 15738.213089345716, 11607.709807254887, 11710.531578736754, 11814.94092529532, 11851.288922664668, 12106.394680266128, 11323.377214252965, 11427.257228280136, 11452.82820757706, 11646.359450230319, 11825.349605771766, 10003.649872254437, 10144.137748291478, 10160.949195253976, 10170.237232207466, 10178.389296642225, 8117.8376432472205, 8197.385196110195, 8255.215754503313, 8332.083470818085, 8339.874901876598, 8266.090730019814, 8352.0, 8369.079401265733, 8418.410711250153, 8472.068072512142], "value": 7140.834177933353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8670719027434, 557.2532806039907, 566.3628418029716, 583.6993948116718, 588.5732843688323, 6102.230353197573, 6144.109104179891, 6229.377062293768, 6344.429001389874, 6369.904451433232, 6215.254169499655, 6239.064140378945, 6243.250809902806, 6273.905891411632, 6280.120783090371, 5126.282320475137, 5130.666506677054, 5143.305653736735, 5187.922181167267, 5205.7397130143345, 4893.140606569498, 4955.256711493269, 4978.576820970222, 4990.825321113762, 5143.639945203838, 4902.8038878444995, 4932.728699921503, 4962.154330393938, 4970.602351811846, 4976.527229913152, 4884.511548845105, 4896.43690975537, 4914.63140264478, 4927.852164435073, 4934.25986102084, 4464.129494748526, 4482.0, 4508.661850361236, 4546.136234115507, 4558.703684260546, 6168.290646575656, 6195.628262304276, 6207.199912025507, 6209.5032397408095, 6235.625862448268, 5713.657180569137, 5750.607141786324, 5858.8242352729485, 5879.8530036749, 5895.675737834417, 6407.71165297558, 6522.782254033604, 6523.836904077389, 6527.902081468782, 6552.901706474407, 4798.5441383068555, 4965.950340496585, 4981.4308492825, 4982.476839931827, 5022.522860328263, 6787.524873258873, 6787.898181527281, 6800.217974932847, 6846.7945961621235, 6883.827904302432, 5078.0, 5144.768485418165, 5152.716600587004, 5159.7678104485385, 5171.0, 5183.377994640592, 5190.92213616796, 5193.091209038404, 5200.0, 5249.632525723239, 5701.287339082614, 5735.369109397963, 5763.452472015236, 5773.88452230953, 5806.535477161817, 6554.246261679968, 6639.3692599203, 6641.269460359356, 6647.800565983028, 6670.199576050905, 1786.7677201963922, 1788.534980904974, 1795.3357257814691, 1811.1397086383863, 1812.7099664053687, 1208.8395140664884, 1272.4210484229654, 1290.2838924396863, 1293.715382615823, 1301.73965206959, 6059.333473317932, 6070.848228794315, 6075.149479072933, 6086.72178842448, 6110.7861224856915, 6566.967165164239, 6586.80239592813, 6626.801195964129, 6690.765823196165, 6736.393724564813, 5830.679312637845, 5895.557833162444, 5995.800839832051, 6007.969960150172, 6020.187274717945, 3490.965090349064, 3517.8592856285463, 3545.982270088633, 3548.6806187443253, 3554.537910071674, 6772.72909083641, 6839.487038472134, 6846.0, 6863.759768408082, 6979.8604027919155, 6922.238553759083, 6933.5493192942295, 6937.0, 6963.338482844122, 6992.168171890393, 6925.58446493212, 6959.164900212007, 6959.582425054513, 6974.455308030128, 7001.92998070023, 6687.164104486939, 6687.799366019027, 6696.229933557704, 6703.899441508283, 6715.0, 6679.599224046573, 6700.597964122168, 6708.262091170065, 6747.325267473213, 6747.561408508432, 6812.82967925786, 6925.926481395391, 6928.896066559107, 6965.930340696528, 6970.965145174445, 5070.771815268248, 5111.769970351269, 5120.692758434357, 5129.153689641316, 5162.457941916045, 6552.803415897531, 6589.934100659124, 6691.397774200345, 6694.59832410057, 6768.187817461936, 6404.487640988803, 6417.743290268337, 6439.67801609927, 6470.870582588228, 6511.2512061113575, 6411.551191416556, 6433.324500927335, 6449.677516124269, 6453.51598630114, 6552.1154644124335, 6379.362063793584, 6398.232212134388, 6433.195850518685, 6500.837479063061, 6544.509161812788, 6492.935070649233, 6532.673366331759, 6568.80293591193, 6578.440832529097, 6654.534182607171, 6246.3753624637175, 6410.423061924263, 6430.3891130342545, 6432.099506069248, 6451.580647257913], "value": 5140.124495487382, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.7558110472382, 977.2377545514502, 984.7882705218378, 990.1979396688678, 997.2171845101592, 20588.1764729411, 20786.688199677, 20965.685514717272, 21366.679499807517, 21406.036728347222, 18165.182566784493, 18216.180271887763, 18336.816631833677, 18343.724844127315, 18343.816561834377, 1030.4435604773432, 1054.7152268887396, 1055.7993981143597, 1056.978860422795, 1057.148995058977, 1047.1256500821785, 1055.9736006599858, 1061.6549621373047, 1062.617457715222, 1067.7117178361837, 1084.7938891610568, 1121.4785124916912, 1121.8822023687517, 1122.259308856155, 1127.61661035248, 1115.336374856963, 1116.2967330581723, 1116.5868628607386, 1117.0560876059717, 1117.201201141188, 795.5226863881683, 815.7675062607187, 819.2708489444399, 819.5779173725537, 823.3084209264247, 21379.8931005344, 21554.137834486603, 21582.136714531556, 21596.352109436742, 21604.243851465122, 23341.53316933652, 24064.518709625885, 24211.273661790176, 24420.877895610585, 24424.0, 18688.532786680305, 18923.526911827175, 18996.145173467226, 19095.713564296548, 19129.904350478297, 4037.2531081749676, 4065.7357271777537, 4070.959290407088, 4071.1654110907193, 4073.959260407388, 135377.0, 157527.0, 157695.2115239428, 160362.0, 161566.99999999884, 18685.439436816916, 19070.713939290923, 19208.71186932197, 19276.036198190035, 19316.71024934627, 34541.481877771854, 34743.30513389718, 34963.65036349655, 35083.64916350855, 35138.47292290618, 9722.756931076638, 9761.755956101013, 9791.069848364394, 9809.0, 9819.36174148678, 4394.209042372404, 4400.603945644907, 4445.82216711328, 4463.375127482155, 4485.775711214492, 6068.75724971005, 6175.289841668266, 6184.072389141665, 6198.81403557894, 6225.221847269091, 1135.7444574970566, 1164.9708757281135, 1177.8292147638545, 1179.1922533064878, 1180.3626041937257, 725.6117976882342, 735.2647352647352, 738.8485360501085, 754.4756394306014, 774.2257742257742, 13325.267110308832, 13581.86418135806, 13584.388702508411, 13976.650583735285, 14049.71900561983, 730.3572855886786, 730.9488335816442, 736.9926300737031, 747.7196051480695, 748.5770539645083, 5979.282486101695, 6020.488258497989, 6045.123457098696, 6069.605475644069, 6178.104174894615, 144964.27517862554, 145471.0, 146822.0, 147259.0, 155943.0, 102608.48695756473, 103507.4824625872, 125365.37317313538, 134551.0, 141912.0, 107150.0, 111860.0, 114092.42953785179, 115438.99999999833, 119844.0, 13942.512012079529, 14125.929370353493, 14160.221187834768, 14211.857881421054, 14650.780238296222, 54552.18171727507, 54797.45202547924, 55676.72161639166, 55907.0, 55934.72032639811, 71906.28093718996, 72172.0, 72903.27096728965, 73239.63380183066, 73282.26717732755, 19195.424137275902, 19816.801831981495, 19842.107105180592, 19864.50338741543, 19871.900640496704, 23513.88243058774, 23793.405164871016, 23917.28248152558, 23973.880130599933, 24125.03499859986, 21759.0, 21788.237411690516, 22044.33866983993, 22281.777182227972, 22332.441688957257, 19118.617627647647, 19332.130054147878, 19346.4196074118, 19482.318118865773, 19524.121414536097, 19480.51298717487, 21116.47208819792, 21611.783882160977, 22001.339959801233, 22522.21172258963, 15634.218289085728, 15760.527184184493, 15858.207089645703, 15885.920570397075, 15955.680886382439, 15501.84498155004, 15843.287052082915, 15926.283317250984, 15926.681466370375, 16180.433684820975], "value": 10328.885626454074, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1390.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 106.0, 106.0, 107.0, 108.0, 109.0, 106.0, 96.0, 105.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 116.0, 115.0, 113.0, 112.0, 141.0, 114.0, 138.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 77.0, 83.0, 83.0, 86.0, 77.0, 78.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 111.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 99.0, 93.0, 99.0, 98.0, 99.0, 98.0, 99.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 46.0, 43.0, 44.0, 44.0, 46.0, 42.0, 43.0], "value": 44.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 38.0, 39.0, 39.0, 40.0, 38.0, 39.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 73.0, 71.0, 73.0, 71.0, 72.0, 72.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 124.0, 113.0, 117.0, 110.0, 108.0, 113.0, 112.0, 111.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 155.0, 159.0, 155.0, 162.0, 163.0, 156.0, 166.0, 155.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 60.0, 65.0, 69.0, 60.0, 57.0, 58.0, 59.0, 60.0, 63.0], "value": 61.9, "unit": "score"}]}]} 06:07:08 INFO - Return code: 0 06:07:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:09 INFO - # TBPL SUCCESS # 06:07:09 INFO - Running post-action listener: _package_coverage_data 06:07:09 INFO - Running post-action listener: _resource_record_post_action 06:07:09 INFO - [mozharness: 2017-09-07 13:07:09.057668Z] Finished run-tests step (success) 06:07:09 INFO - Running post-run listener: _resource_record_post_run 06:07:09 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 401522688; Read time: 376; Write time: 256012 06:07:09 INFO - TinderboxPrint: CPU usage
13.1% 06:07:09 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 376 06:07:09 INFO - TinderboxPrint: I/O write bytes / time
401,522,688 / 256,012 06:07:09 INFO - TinderboxPrint: CPU idle
8,213.2 (86.9%) 06:07:09 INFO - TinderboxPrint: CPU user
1,184.4 (12.5%) 06:07:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109658112; Read time: 192; Write time: 86252 06:07:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:07:09 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 12288; Write bytes: 282443776; Read time: 184; Write time: 169136 06:07:09 INFO - Running post-run listener: _upload_blobber_files 06:07:09 INFO - Blob upload gear active. 06:07:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:09 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 06:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:16 INFO - (blobuploader) - INFO - Done attempting. 06:07:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:17 INFO - (blobuploader) - INFO - Done attempting. 06:07:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:07:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:18 INFO - (blobuploader) - INFO - Done attempting. 06:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:19 INFO - (blobuploader) - INFO - Done attempting. 06:07:19 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:19 INFO - Return code: 0 06:07:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0125c88db04321303bee884d51c315465920677ab4de2fe79738831d86ed46e1c091221885e215ddfb418160bffb08b2ab866a008ca804a16fedb7cda97beaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/534298ca07bb806f3c88d0228711743a68dee945ce20fcf478f2f77f5c27b88797baefe723ebfe0e02afb4bb97efbfa76df96eee99baaade992fdbd6c8c78b0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7200dfbb9c6398b9a31339d0900482dc6c276b1a79a7045d9b6e1bbd889fe0550160009602ebfc0dd99bff965ad92af3f33d14790873f9f59c10f5849b601155", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6473026707d7ef6c88ca4f205f3fc67602f6616bb01bb0c45805bd844604f0d67df93d3c98ec3b57b1bef22bf2767a055ab5310a5b54ef67d8ce364266bc4f4"} 06:07:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:19 INFO - Contents: 06:07:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0125c88db04321303bee884d51c315465920677ab4de2fe79738831d86ed46e1c091221885e215ddfb418160bffb08b2ab866a008ca804a16fedb7cda97beaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/534298ca07bb806f3c88d0228711743a68dee945ce20fcf478f2f77f5c27b88797baefe723ebfe0e02afb4bb97efbfa76df96eee99baaade992fdbd6c8c78b0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7200dfbb9c6398b9a31339d0900482dc6c276b1a79a7045d9b6e1bbd889fe0550160009602ebfc0dd99bff965ad92af3f33d14790873f9f59c10f5849b601155", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6473026707d7ef6c88ca4f205f3fc67602f6616bb01bb0c45805bd844604f0d67df93d3c98ec3b57b1bef22bf2767a055ab5310a5b54ef67d8ce364266bc4f4"} 06:07:19 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:19 INFO - Copying logs to upload dir... 06:07:19 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.430219 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 06:07:19.887651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 06:07:19.894138) ========= 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=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 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/sha512/d0125c88db04321303bee884d51c315465920677ab4de2fe79738831d86ed46e1c091221885e215ddfb418160bffb08b2ab866a008ca804a16fedb7cda97beaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/534298ca07bb806f3c88d0228711743a68dee945ce20fcf478f2f77f5c27b88797baefe723ebfe0e02afb4bb97efbfa76df96eee99baaade992fdbd6c8c78b0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7200dfbb9c6398b9a31339d0900482dc6c276b1a79a7045d9b6e1bbd889fe0550160009602ebfc0dd99bff965ad92af3f33d14790873f9f59c10f5849b601155", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6473026707d7ef6c88ca4f205f3fc67602f6616bb01bb0c45805bd844604f0d67df93d3c98ec3b57b1bef22bf2767a055ab5310a5b54ef67d8ce364266bc4f4"} build_url:https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/VXWD8froSPKZ2PF74DDRPw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0125c88db04321303bee884d51c315465920677ab4de2fe79738831d86ed46e1c091221885e215ddfb418160bffb08b2ab866a008ca804a16fedb7cda97beaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/534298ca07bb806f3c88d0228711743a68dee945ce20fcf478f2f77f5c27b88797baefe723ebfe0e02afb4bb97efbfa76df96eee99baaade992fdbd6c8c78b0b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7200dfbb9c6398b9a31339d0900482dc6c276b1a79a7045d9b6e1bbd889fe0550160009602ebfc0dd99bff965ad92af3f33d14790873f9f59c10f5849b601155", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6473026707d7ef6c88ca4f205f3fc67602f6616bb01bb0c45805bd844604f0d67df93d3c98ec3b57b1bef22bf2767a055ab5310a5b54ef67d8ce364266bc4f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 06:07:19.923047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 06:07:19.923348) ========= 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=232498196343f89f466a4a9a000001c8-1504788386.39795-1650425913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 06:07:20.003336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 06:07:20.003614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 06:07:20.006882) ========= ========= Total master_lag: 0.30 =========