builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1506956865.56 results: success (0) revision: 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.556046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.556404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.556699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.612250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.612579) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 08:07:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.9M=0s 2017-10-02 08:07:45 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118487 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.803518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.803801) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024089 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:45.919186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 08:07:45.919612) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 --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=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 08:07:46,141 truncating revision to first 12 chars 2017-10-02 08:07:46,141 Setting DEBUG logging. 2017-10-02 08:07:46,141 attempt 1/10 2017-10-02 08:07:46,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1c9c05f5e5bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 08:07:47,357 unpacking tar archive at: mozilla-beta-1c9c05f5e5bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.577309 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 08:07:47.535894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:47.540245) ========= script_repo_revision: 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:47.540624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:47.540884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 08:07:47.569884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 08:07:47.570240) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:47 INFO - MultiFileLogger online at 20171002 08:07:47 in /builds/slave/test 08:07:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 08:07:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:47 INFO - {'append_to_log': False, 08:07:47 INFO - 'base_work_dir': '/builds/slave/test', 08:07:47 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:07:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:47 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:07:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:47 INFO - 'code_coverage': False, 08:07:47 INFO - 'config_files': ('talos/linux_config.py',), 08:07:47 INFO - 'default_actions': ('clobber', 08:07:47 INFO - 'read-buildbot-config', 08:07:47 INFO - 'download-and-extract', 08:07:47 INFO - 'populate-webroot', 08:07:47 INFO - 'create-virtualenv', 08:07:47 INFO - 'install', 08:07:47 INFO - 'setup-mitmproxy', 08:07:47 INFO - 'run-tests'), 08:07:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:47 INFO - 'disable_ccov_upload': False, 08:07:47 INFO - 'disable_stylo': False, 08:07:47 INFO - 'download_minidump_stackwalk': True, 08:07:47 INFO - 'download_symbols': 'ondemand', 08:07:47 INFO - 'enable_stylo': False, 08:07:47 INFO - 'enable_webrender': False, 08:07:47 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:07:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:47 INFO - 'gecko_profile': False, 08:07:47 INFO - 'gecko_profile_interval': 0, 08:07:47 INFO - 'installer_path': 'installer.exe', 08:07:47 INFO - 'log_level': 'info', 08:07:47 INFO - 'log_name': 'talos', 08:07:47 INFO - 'log_to_console': True, 08:07:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:47 INFO - 'opt_config_files': (), 08:07:47 INFO - 'pip_index': False, 08:07:47 INFO - 'suite': 'dromaeojs-e10s', 08:07:47 INFO - 'system_bits': '32', 08:07:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:47 INFO - 'title': 'talos-linux64-ix-051', 08:07:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:47 INFO - 'use_talos_json': True, 08:07:47 INFO - 'verify': 'False', 08:07:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:47 INFO - 'work_dir': 'build'} 08:07:47 INFO - [mozharness: 2017-10-02 15:07:47.923064Z] Running clobber step. 08:07:47 INFO - Running pre-action listener: _resource_record_pre_action 08:07:47 INFO - Running main action method: clobber 08:07:47 INFO - rmtree: /builds/slave/test/build 08:07:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:48 INFO - Running post-action listener: _resource_record_post_action 08:07:48 INFO - [mozharness: 2017-10-02 15:07:48.919066Z] Finished clobber step (success) 08:07:48 INFO - [mozharness: 2017-10-02 15:07:48.919163Z] Running read-buildbot-config step. 08:07:48 INFO - Running pre-action listener: _resource_record_pre_action 08:07:48 INFO - Running main action method: read_buildbot_config 08:07:48 INFO - Using buildbot properties: 08:07:48 INFO - { 08:07:48 INFO - "project": "", 08:07:48 INFO - "product": "firefox", 08:07:48 INFO - "who": "ffxbld@noreply.mozilla.org", 08:07:48 INFO - "installer_path": "public/build/target.tar.bz2", 08:07:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:07:48 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:07:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:07:48 INFO - "stage_platform": "linux64", 08:07:48 INFO - "basedir": "/builds/slave/test", 08:07:48 INFO - "buildnumber": 145, 08:07:48 INFO - "platform": "ubuntu64_hw", 08:07:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:48 INFO - "slavebuilddir": "test", 08:07:48 INFO - "taskId": "Tg1jK1xrQyyPeWDymOxwFA", 08:07:48 INFO - "branch": "mozilla-beta", 08:07:48 INFO - "script_repo_revision": "production", 08:07:48 INFO - "revision": "1c9c05f5e5bd073187b2d16e0f87438bd730d2a2", 08:07:48 INFO - "slavename": "talos-linux64-ix-051", 08:07:48 INFO - "repo_path": "releases/mozilla-beta" 08:07:48 INFO - } 08:07:48 INFO - Finding installer, test and symbols from parent task. 08:07:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tg1jK1xrQyyPeWDymOxwFA'}, attempt #1 08:07:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tg1jK1xrQyyPeWDymOxwFA'}, attempt #1 08:07:49 INFO - Task dependencies: cjAJBJ5AR2i7MSDU-xykbQ 08:07:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ'}, attempt #1 08:07:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 08:07:50 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.test_packages.json 08:07:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.crashreporter-symbols.zip 08:07:50 INFO - Running post-action listener: _resource_record_post_action 08:07:50 INFO - [mozharness: 2017-10-02 15:07:50.267156Z] Finished read-buildbot-config step (success) 08:07:50 INFO - [mozharness: 2017-10-02 15:07:50.267371Z] Running download-and-extract step. 08:07:50 INFO - Running pre-action listener: _resource_record_pre_action 08:07:50 INFO - Running main action method: download_and_extract 08:07:50 INFO - mkdir: /builds/slave/test/build/tests 08:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:50 INFO - trying https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.test_packages.json 08:07:50 INFO - Downloading https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:07:50 INFO - Downloaded 989 bytes. 08:07:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:07:50 INFO - Using the following test package requirements: 08:07:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:07:50 INFO - u'common': [u'target.common.tests.zip'], 08:07:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:07:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:07:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:07:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:07:50 INFO - u'mozbase': [u'target.common.tests.zip'], 08:07:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:07:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:07:50 INFO - u'web-platform': [u'target.common.tests.zip', 08:07:50 INFO - u'target.web-platform.tests.tar.gz'], 08:07:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:07:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:07:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.common.tests.zip 08:07:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:07:50 INFO - Fetch https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.common.tests.zip into memory 08:07:51 INFO - Content-Length response header: 55181738 08:07:51 INFO - Bytes received: 55181738 08:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.talos.tests.zip 08:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.talos.tests.zip into memory 08:08:03 INFO - Content-Length response header: 14509184 08:08:03 INFO - Bytes received: 14509184 08:08: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')]} 08:08:03 INFO - trying https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 08:08:03 INFO - Downloading https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:08:04 INFO - Downloaded 53455282 bytes. 08:08:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 08:08:04 INFO - mkdir: /builds/slave/test/properties 08:08:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:04 INFO - Contents: 08:08:04 INFO - build_url:https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 08:08:04 INFO - Running post-action listener: _resource_record_post_action 08:08:04 INFO - Running post-action listener: find_tests_for_verification 08:08:04 INFO - Running post-action listener: set_extra_try_arguments 08:08:04 INFO - [mozharness: 2017-10-02 15:08:04.690342Z] Finished download-and-extract step (success) 08:08:04 INFO - [mozharness: 2017-10-02 15:08:04.690437Z] Running populate-webroot step. 08:08:04 INFO - Running pre-action listener: _resource_record_pre_action 08:08:04 INFO - Running main action method: populate_webroot 08:08:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['tresize', 08:08:04 INFO - 'tcanvasmark']}, 08:08:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['dromaeo_css', 08:08:04 INFO - 'kraken']}, 08:08:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'tests': ['damp', 'tps']}, 08:08:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['damp', 'tps']}, 08:08:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['dromaeo_dom']}, 08:08:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:08:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['basic_compositor_video', 08:08:04 INFO - 'glvideo']}, 08:08:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:08:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['ts_paint_webext', 08:08:04 INFO - 'tp5o_webext']}, 08:08:04 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:04 INFO - 'ts_paint', 08:08:04 INFO - 'tpaint', 08:08:04 INFO - 'sessionrestore', 08:08:04 INFO - 'sessionrestore_many_windows', 08:08:04 INFO - 'sessionrestore_no_auto_restore', 08:08:04 INFO - 'tabpaint']}, 08:08:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['a11yr', 08:08:04 INFO - 'ts_paint', 08:08:04 INFO - 'tpaint', 08:08:04 INFO - 'sessionrestore', 08:08:04 INFO - 'sessionrestore_many_windows', 08:08:04 INFO - 'sessionrestore_no_auto_restore', 08:08:04 INFO - 'tabpaint']}, 08:08:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:08:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:08:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['perf_reftest_singletons']}, 08:08:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['bloom_basic']}, 08:08:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:04 INFO - 'tsvgr_opacity', 08:08:04 INFO - 'tart', 08:08:04 INFO - 'tscrollx', 08:08:04 INFO - 'tsvg_static']}, 08:08:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['tsvgx', 08:08:04 INFO - 'tsvgr_opacity', 08:08:04 INFO - 'tart', 08:08:04 INFO - 'tscrollx', 08:08:04 INFO - 'tsvg_static']}, 08:08:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:08:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo'], 08:08:04 INFO - 'tests': ['tp5o']}, 08:08:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:08:04 INFO - 'talos_options': ['--mitmproxy', 08:08:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:08:04 INFO - '--firstNonBlankPaint'], 08:08:04 INFO - 'tests': ['tp6_google', 08:08:04 INFO - 'tp6_youtube', 08:08:04 INFO - 'tp6_amazon', 08:08:04 INFO - 'tp6_facebook']}, 08:08:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo', 08:08:04 INFO - '--mitmproxy', 08:08:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:08:04 INFO - '--firstNonBlankPaint'], 08:08:04 INFO - 'tests': ['tp6_google', 08:08:04 INFO - 'tp6_youtube', 08:08:04 INFO - 'tp6_amazon', 08:08:04 INFO - 'tp6_facebook']}, 08:08:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:08:04 INFO - 'talos_options': ['--stylo-threads=1', 08:08:04 INFO - '--mitmproxy', 08:08:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:08:04 INFO - '--firstNonBlankPaint'], 08:08:04 INFO - 'tests': ['tp6_google', 08:08:04 INFO - 'tp6_youtube', 08:08:04 INFO - 'tp6_amazon', 08:08:04 INFO - 'tp6_facebook']}, 08:08:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--xperf_path', 08:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:04 INFO - 'tests': ['tp5n']}, 08:08:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:08:04 INFO - 'talos_options': ['--disable-stylo', 08:08:04 INFO - '--xperf_path', 08:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:04 INFO - 'tests': ['tp5n']}}} 08:08:04 INFO - Running post-action listener: _resource_record_post_action 08:08:04 INFO - [mozharness: 2017-10-02 15:08:04.705226Z] Finished populate-webroot step (success) 08:08:04 INFO - [mozharness: 2017-10-02 15:08:04.705315Z] Running create-virtualenv step. 08:08:04 INFO - Running pre-action listener: _resource_record_pre_action 08:08:04 INFO - Running main action method: create_virtualenv 08:08:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:08:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:08:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:08:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:05 INFO - Installing pip...............done. 08:08:05 INFO - Return code: 0 08:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:08:05 INFO - Reading from file tmpfile_stdout 08:08:05 INFO - Output received: 08:08: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) 08:08:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08: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')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08: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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08: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 08:08: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 08:08:05 INFO - Using env: {'DISPLAY': ':0', 08:08:05 INFO - 'HOME': '/home/cltbld', 08:08:05 INFO - 'LANG': 'en_US.UTF-8', 08:08:05 INFO - 'LANGUAGE': 'en_US:en', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MAIL': '/var/mail/cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SHLVL': '1', 08:08:05 INFO - 'TERM': 'linux', 08:08:05 INFO - 'TMOUT': '86400', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - '_': '/tools/buildbot/bin/python'} 08:08:07 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:08:07 INFO - Downloading/unpacking pip>=1.5 08:08:07 INFO - Running setup.py egg_info for package pip 08:08:07 INFO - warning: no files found matching 'pip/cacert.pem' 08:08:07 INFO - warning: no files found matching '*.html' under directory 'docs' 08:08:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:08:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:08:07 INFO - Installing collected packages: pip 08:08:07 INFO - Found existing installation: pip 1.1 08:08:07 INFO - Uninstalling pip: 08:08:07 INFO - Successfully uninstalled pip 08:08:07 INFO - Running setup.py install for pip 08:08:07 INFO - warning: no files found matching 'pip/cacert.pem' 08:08:07 INFO - warning: no files found matching '*.html' under directory 'docs' 08:08:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:08:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:08:07 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:08:07 INFO - Successfully installed pip 08:08:07 INFO - Cleaning up... 08:08:07 INFO - Return code: 0 08:08:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:08:07 INFO - Using env: {'DISPLAY': ':0', 08:08:07 INFO - 'HOME': '/home/cltbld', 08:08:07 INFO - 'LANG': 'en_US.UTF-8', 08:08:07 INFO - 'LANGUAGE': 'en_US:en', 08:08:07 INFO - 'LOGNAME': 'cltbld', 08:08:07 INFO - 'MAIL': '/var/mail/cltbld', 08:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:07 INFO - 'MOZ_NO_REMOTE': '1', 08:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:07 INFO - 'NO_EM_RESTART': '1', 08:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:07 INFO - 'PWD': '/builds/slave/test', 08:08:07 INFO - 'SHELL': '/bin/bash', 08:08:07 INFO - 'SHLVL': '1', 08:08:07 INFO - 'TERM': 'linux', 08:08:07 INFO - 'TMOUT': '86400', 08:08:07 INFO - 'USER': 'cltbld', 08:08:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:07 INFO - '_': '/tools/buildbot/bin/python'} 08:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:07 INFO - Downloading/unpacking psutil>=3.1.1 08:08:07 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 08:08:07 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 08:08:07 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 08:08:07 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 08:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:08 INFO - Installing collected packages: psutil 08:08:08 INFO - Running setup.py install for psutil 08:08:08 INFO - building 'psutil._psutil_linux' extension 08:08: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 08:08: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 08:08:08 INFO - building 'psutil._psutil_posix' extension 08:08: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 08:08: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 08:08:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:09 INFO - Successfully installed psutil 08:08:09 INFO - Cleaning up... 08:08:09 INFO - Return code: 0 08:08:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08: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')]} 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:08: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 mozsystemmonitor==0.3 08:08:09 INFO - Using env: {'DISPLAY': ':0', 08:08:09 INFO - 'HOME': '/home/cltbld', 08:08:09 INFO - 'LANG': 'en_US.UTF-8', 08:08:09 INFO - 'LANGUAGE': 'en_US:en', 08:08:09 INFO - 'LOGNAME': 'cltbld', 08:08:09 INFO - 'MAIL': '/var/mail/cltbld', 08:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:09 INFO - 'MOZ_NO_REMOTE': '1', 08:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:09 INFO - 'NO_EM_RESTART': '1', 08:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:09 INFO - 'PWD': '/builds/slave/test', 08:08:09 INFO - 'SHELL': '/bin/bash', 08:08:09 INFO - 'SHLVL': '1', 08:08:09 INFO - 'TERM': 'linux', 08:08:09 INFO - 'TMOUT': '86400', 08:08:09 INFO - 'USER': 'cltbld', 08:08:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:09 INFO - '_': '/tools/buildbot/bin/python'} 08:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:10 INFO - Installing collected packages: mozsystemmonitor 08:08:10 INFO - Running setup.py install for mozsystemmonitor 08:08:10 INFO - Successfully installed mozsystemmonitor 08:08:10 INFO - Cleaning up... 08:08:11 INFO - Return code: 0 08:08:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08: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')]} 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08: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', '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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:08: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 jsonschema==2.5.1 08:08:11 INFO - Using env: {'DISPLAY': ':0', 08:08:11 INFO - 'HOME': '/home/cltbld', 08:08:11 INFO - 'LANG': 'en_US.UTF-8', 08:08:11 INFO - 'LANGUAGE': 'en_US:en', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MAIL': '/var/mail/cltbld', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SHLVL': '1', 08:08:11 INFO - 'TERM': 'linux', 08:08:11 INFO - 'TMOUT': '86400', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - '_': '/tools/buildbot/bin/python'} 08:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:13 INFO - warning: no files found matching '*.txt' 08:08:13 INFO - no previously-included directories found matching 'build' 08:08:13 INFO - no previously-included directories found matching 'dist' 08:08:13 INFO - no previously-included directories found matching '.git*' 08:08:13 INFO - Installing collected packages: jsonschema, functools32 08:08:13 INFO - Running setup.py install for functools32 08:08:13 INFO - warning: no files found matching '*.txt' 08:08:13 INFO - no previously-included directories found matching 'build' 08:08:13 INFO - no previously-included directories found matching 'dist' 08:08:13 INFO - no previously-included directories found matching '.git*' 08:08:13 INFO - Successfully installed jsonschema functools32 08:08:13 INFO - Cleaning up... 08:08:13 INFO - Return code: 0 08:08:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:08:13 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')]} 08:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:13 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')]} 08:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:13 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:13 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 08:08:13 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 08:08:13 INFO - Using env: {'DISPLAY': ':0', 08:08:13 INFO - 'HOME': '/home/cltbld', 08:08:13 INFO - 'LANG': 'en_US.UTF-8', 08:08:13 INFO - 'LANGUAGE': 'en_US:en', 08:08:13 INFO - 'LOGNAME': 'cltbld', 08:08:13 INFO - 'MAIL': '/var/mail/cltbld', 08:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:13 INFO - 'MOZ_NO_REMOTE': '1', 08:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:13 INFO - 'NO_EM_RESTART': '1', 08:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:13 INFO - 'PWD': '/builds/slave/test', 08:08:13 INFO - 'SHELL': '/bin/bash', 08:08:13 INFO - 'SHLVL': '1', 08:08:13 INFO - 'TERM': 'linux', 08:08:13 INFO - 'TMOUT': '86400', 08:08:13 INFO - 'USER': 'cltbld', 08:08:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:13 INFO - '_': '/tools/buildbot/bin/python'} 08:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:08:13 INFO - Cleaning up... 08:08:13 INFO - Return code: 0 08:08:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:13 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')]} 08:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:13 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')]} 08:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:13 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:13 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 08:08:13 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 08:08:13 INFO - Using env: {'DISPLAY': ':0', 08:08:13 INFO - 'HOME': '/home/cltbld', 08:08:13 INFO - 'LANG': 'en_US.UTF-8', 08:08:13 INFO - 'LANGUAGE': 'en_US:en', 08:08:13 INFO - 'LOGNAME': 'cltbld', 08:08:13 INFO - 'MAIL': '/var/mail/cltbld', 08:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:13 INFO - 'MOZ_NO_REMOTE': '1', 08:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:13 INFO - 'NO_EM_RESTART': '1', 08:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:13 INFO - 'PWD': '/builds/slave/test', 08:08:13 INFO - 'SHELL': '/bin/bash', 08:08:13 INFO - 'SHLVL': '1', 08:08:13 INFO - 'TERM': 'linux', 08:08:13 INFO - 'TMOUT': '86400', 08:08:13 INFO - 'USER': 'cltbld', 08:08:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:13 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:14 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 08:08:14 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 08:08:14 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 08:08:14 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 08:08:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 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 08:08:15 INFO - Downloading docopt-0.6.1.tar.gz 08:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:15 INFO - Running setup.py install for blobuploader 08:08:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:15 INFO - Running setup.py install for requests 08:08:16 INFO - Running setup.py install for docopt 08:08:16 INFO - Successfully installed blobuploader requests docopt 08:08:16 INFO - Cleaning up... 08:08:16 INFO - Return code: 0 08:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:16 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')]} 08:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:16 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')]} 08:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:16 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:16 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 08:08:16 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 08:08:16 INFO - Using env: {'DISPLAY': ':0', 08:08:16 INFO - 'HOME': '/home/cltbld', 08:08:16 INFO - 'LANG': 'en_US.UTF-8', 08:08:16 INFO - 'LANGUAGE': 'en_US:en', 08:08:16 INFO - 'LOGNAME': 'cltbld', 08:08:16 INFO - 'MAIL': '/var/mail/cltbld', 08:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:16 INFO - 'MOZ_NO_REMOTE': '1', 08:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:16 INFO - 'NO_EM_RESTART': '1', 08:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:16 INFO - 'PWD': '/builds/slave/test', 08:08:16 INFO - 'SHELL': '/bin/bash', 08:08:16 INFO - 'SHLVL': '1', 08:08:16 INFO - 'TERM': 'linux', 08:08:16 INFO - 'TMOUT': '86400', 08:08:16 INFO - 'USER': 'cltbld', 08:08:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:16 INFO - '_': '/tools/buildbot/bin/python'} 08:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:16 INFO - Running setup.py (path:/tmp/pip-ILG69B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:16 INFO - Running setup.py (path:/tmp/pip-dLDM5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:16 INFO - Running setup.py (path:/tmp/pip-LSmgS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:16 INFO - Running setup.py (path:/tmp/pip-eFS5p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:16 INFO - Running setup.py (path:/tmp/pip-_9u4PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:16 INFO - Running setup.py (path:/tmp/pip-kXY81d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:17 INFO - Running setup.py (path:/tmp/pip-SZjkmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:17 INFO - Running setup.py (path:/tmp/pip-umrFO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:17 INFO - Running setup.py (path:/tmp/pip-99vQU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:17 INFO - Running setup.py (path:/tmp/pip-5XVxhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:17 INFO - Running setup.py (path:/tmp/pip-7Gapo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:17 INFO - Running setup.py (path:/tmp/pip-47Aykp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:17 INFO - Running setup.py (path:/tmp/pip-Qh3nwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:17 INFO - Running setup.py (path:/tmp/pip-5mKCMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:17 INFO - Running setup.py (path:/tmp/pip-58LZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:17 INFO - Running setup.py (path:/tmp/pip-ofipyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:17 INFO - Running setup.py (path:/tmp/pip-RETweg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:17 INFO - Running setup.py install for manifestparser 08:08:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:17 INFO - Running setup.py install for mozcrash 08:08:17 INFO - Running setup.py install for mozdebug 08:08:18 INFO - Running setup.py install for mozdevice 08:08:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for mozfile 08:08:18 INFO - Running setup.py install for mozhttpd 08:08:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for mozinfo 08:08:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for mozInstall 08:08:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for mozleak 08:08:18 INFO - Running setup.py install for mozlog 08:08:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for moznetwork 08:08:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:18 INFO - Running setup.py install for mozprocess 08:08:18 INFO - Running setup.py install for mozprofile 08:08:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozrunner 08:08:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozscreenshot 08:08:19 INFO - Running setup.py install for moztest 08:08:19 INFO - Running setup.py install for mozversion 08:08:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:19 INFO - Cleaning up... 08:08:19 INFO - Return code: 0 08:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:19 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')]} 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:19 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')]} 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:19 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:19 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 08:08:19 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 08:08:19 INFO - Using env: {'DISPLAY': ':0', 08:08:19 INFO - 'HOME': '/home/cltbld', 08:08:19 INFO - 'LANG': 'en_US.UTF-8', 08:08:19 INFO - 'LANGUAGE': 'en_US:en', 08:08:19 INFO - 'LOGNAME': 'cltbld', 08:08:19 INFO - 'MAIL': '/var/mail/cltbld', 08:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:19 INFO - 'MOZ_NO_REMOTE': '1', 08:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:19 INFO - 'NO_EM_RESTART': '1', 08:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:19 INFO - 'PWD': '/builds/slave/test', 08:08:19 INFO - 'SHELL': '/bin/bash', 08:08:19 INFO - 'SHLVL': '1', 08:08:19 INFO - 'TERM': 'linux', 08:08:19 INFO - 'TMOUT': '86400', 08:08:19 INFO - 'USER': 'cltbld', 08:08:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:19 INFO - '_': '/tools/buildbot/bin/python'} 08:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:19 INFO - Running setup.py (path:/tmp/pip-ivRR5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:19 INFO - Running setup.py (path:/tmp/pip-A9xr_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:19 INFO - Running setup.py (path:/tmp/pip-FNsQpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:19 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)) 08:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:19 INFO - Running setup.py (path:/tmp/pip-xdpEEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:20 INFO - Running setup.py (path:/tmp/pip-L_teDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:20 INFO - Running setup.py (path:/tmp/pip-00pwiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:20 INFO - Running setup.py (path:/tmp/pip-5gWzRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:20 INFO - Running setup.py (path:/tmp/pip-NEbqVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:20 INFO - Running setup.py (path:/tmp/pip-WTz2c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:20 INFO - Running setup.py (path:/tmp/pip-PiBYxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:20 INFO - Running setup.py (path:/tmp/pip-BHHAHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:20 INFO - Running setup.py (path:/tmp/pip-K7pLaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:20 INFO - Running setup.py (path:/tmp/pip-2WAw18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:20 INFO - Running setup.py (path:/tmp/pip-7RAcCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:20 INFO - Running setup.py (path:/tmp/pip-QjnjfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:20 INFO - Running setup.py (path:/tmp/pip-TOk44u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:20 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)) 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:20 INFO - Running setup.py (path:/tmp/pip-CYhFIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:20 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)) 08:08:20 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)) 08:08:20 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)) 08:08:20 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)) 08:08:20 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)) 08:08:20 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)) 08:08:20 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)) 08:08:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08: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 08:08: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 08:08: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 08:08: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 08:08:22 INFO - Downloading blessings-1.6.tar.gz 08:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:22 INFO - Installing collected packages: blessings 08:08:22 INFO - Running setup.py install for blessings 08:08:22 INFO - Successfully installed blessings 08:08:22 INFO - Cleaning up... 08:08:22 INFO - Return code: 0 08:08:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:22 INFO - Reading from file tmpfile_stdout 08:08:22 INFO - Current package versions: 08:08:22 INFO - argparse == 1.2.1 08:08:22 INFO - blessings == 1.6 08:08:22 INFO - blobuploader == 1.2.4 08:08:22 INFO - docopt == 0.6.1 08:08:22 INFO - functools32 == 3.2.3-2 08:08:22 INFO - jsonschema == 2.5.1 08:08:22 INFO - manifestparser == 1.1 08:08:22 INFO - mozInstall == 1.13 08:08:22 INFO - mozcrash == 1.0 08:08:22 INFO - mozdebug == 0.1 08:08:22 INFO - mozdevice == 0.51 08:08:22 INFO - mozfile == 1.2 08:08:22 INFO - mozhttpd == 0.7 08:08:22 INFO - mozinfo == 0.10 08:08:22 INFO - mozleak == 0.1 08:08:22 INFO - mozlog == 3.5 08:08:22 INFO - moznetwork == 0.27 08:08:22 INFO - mozprocess == 0.25 08:08:22 INFO - mozprofile == 0.28 08:08:22 INFO - mozrunner == 6.13 08:08:22 INFO - mozscreenshot == 0.1 08:08:22 INFO - mozsystemmonitor == 0.3 08:08:22 INFO - moztest == 0.8 08:08:22 INFO - mozversion == 1.4 08:08:22 INFO - psutil == 3.1.1 08:08:22 INFO - requests == 1.2.3 08:08:22 INFO - wsgiref == 0.1.2 08:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08: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')]} 08:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:22 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:22 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 08:08:22 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 08:08:22 INFO - Using env: {'DISPLAY': ':0', 08:08:22 INFO - 'HOME': '/home/cltbld', 08:08:22 INFO - 'LANG': 'en_US.UTF-8', 08:08:22 INFO - 'LANGUAGE': 'en_US:en', 08:08:22 INFO - 'LOGNAME': 'cltbld', 08:08:22 INFO - 'MAIL': '/var/mail/cltbld', 08:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:22 INFO - 'MOZ_NO_REMOTE': '1', 08:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:22 INFO - 'NO_EM_RESTART': '1', 08:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:22 INFO - 'PWD': '/builds/slave/test', 08:08:22 INFO - 'SHELL': '/bin/bash', 08:08:22 INFO - 'SHLVL': '1', 08:08:22 INFO - 'TERM': 'linux', 08:08:22 INFO - 'TMOUT': '86400', 08:08:22 INFO - 'USER': 'cltbld', 08:08:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:22 INFO - '_': '/tools/buildbot/bin/python'} 08:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:08:22 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 08:08:22 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 08:08:22 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 08:08:22 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 08:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:08:23 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)) 08:08:23 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)) 08:08:23 INFO - Installing collected packages: simplejson 08:08:23 INFO - Running setup.py install for simplejson 08:08:24 INFO - building 'simplejson._speedups' extension 08:08:24 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 08:08:24 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 08:08:24 INFO - Successfully installed simplejson 08:08:24 INFO - Cleaning up... 08:08:24 INFO - Return code: 0 08:08:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:24 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')]} 08:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:24 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')]} 08:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:25 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 0x14f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', '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 08:08:25 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 08:08:25 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 08:08:25 INFO - Using env: {'DISPLAY': ':0', 08:08:25 INFO - 'HOME': '/home/cltbld', 08:08:25 INFO - 'LANG': 'en_US.UTF-8', 08:08:25 INFO - 'LANGUAGE': 'en_US:en', 08:08:25 INFO - 'LOGNAME': 'cltbld', 08:08:25 INFO - 'MAIL': '/var/mail/cltbld', 08:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:25 INFO - 'MOZ_NO_REMOTE': '1', 08:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:25 INFO - 'NO_EM_RESTART': '1', 08:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:25 INFO - 'PWD': '/builds/slave/test', 08:08:25 INFO - 'SHELL': '/bin/bash', 08:08:25 INFO - 'SHLVL': '1', 08:08:25 INFO - 'TERM': 'linux', 08:08:25 INFO - 'TMOUT': '86400', 08:08:25 INFO - 'USER': 'cltbld', 08:08:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:25 INFO - '_': '/tools/buildbot/bin/python'} 08:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:08:25 INFO - Cleaning up... 08:08:25 INFO - Return code: 0 08:08:25 INFO - Running post-action listener: _resource_record_post_action 08:08:25 INFO - Running post-action listener: _start_resource_monitoring 08:08:25 INFO - Starting resource monitoring. 08:08:25 INFO - [mozharness: 2017-10-02 15:08:25.262968Z] Finished create-virtualenv step (success) 08:08:25 INFO - [mozharness: 2017-10-02 15:08:25.263434Z] Running install step. 08:08:25 INFO - Running pre-action listener: _resource_record_pre_action 08:08:25 INFO - Running main action method: install 08:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:25 INFO - Reading from file tmpfile_stdout 08:08:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:25 INFO - Reading from file tmpfile_stdout 08:08:25 INFO - Output received: 08:08:25 INFO - Usage: mozinstall [options] installer 08:08:25 INFO - Options: 08:08:25 INFO - -h, --help show this help message and exit 08:08:25 INFO - -d DEST, --destination=DEST 08:08:25 INFO - Directory to install application into. [default: 08:08:25 INFO - "/builds/slave/test"] 08:08:25 INFO - --app=APP Application being installed. [default: firefox] 08:08:25 INFO - mkdir: /builds/slave/test/build/application 08:08:25 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'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:08:40 INFO - Reading from file tmpfile_stdout 08:08:40 INFO - Output received: 08:08:40 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:40 INFO - Running post-action listener: _resource_record_post_action 08:08:40 INFO - [mozharness: 2017-10-02 15:08:40.159071Z] Finished install step (success) 08:08:40 INFO - [mozharness: 2017-10-02 15:08:40.159216Z] Running setup-mitmproxy step. 08:08:40 INFO - Running pre-action listener: _resource_record_pre_action 08:08:40 INFO - Running main action method: setup_mitmproxy 08:08:40 INFO - Skipping: mitmproxy is not required 08:08:40 INFO - Running post-action listener: _resource_record_post_action 08:08:40 INFO - [mozharness: 2017-10-02 15:08:40.159741Z] Finished setup-mitmproxy step (success) 08:08:40 INFO - [mozharness: 2017-10-02 15:08:40.159842Z] Running run-tests step. 08:08:40 INFO - Running pre-action listener: _resource_record_pre_action 08:08:40 INFO - Running pre-action listener: _set_gcov_prefix 08:08:40 INFO - Running main action method: run_tests 08:08:40 WARNING - Try message not found. 08:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:40 INFO - Python 2.7.3 08:08:40 INFO - Return code: 0 08:08:40 INFO - grabbing minidump binary from tooltool 08:08: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')]} 08:08: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 0x185f090>, '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 0x185fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1859f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08: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 08:08: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 08:08: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 08:08:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:40 INFO - Return code: 0 08:08:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - ENV: RUST_BACKTRACE is now full 08:08:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 08:08:40 INFO - Using env: {'DISPLAY': ':0', 08:08:40 INFO - 'HOME': '/home/cltbld', 08:08:40 INFO - 'LANG': 'en_US.UTF-8', 08:08:40 INFO - 'LANGUAGE': 'en_US:en', 08:08:40 INFO - 'LOGNAME': 'cltbld', 08:08:40 INFO - 'MAIL': '/var/mail/cltbld', 08:08:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:40 INFO - 'MOZ_NO_REMOTE': '1', 08:08:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:40 INFO - 'NO_EM_RESTART': '1', 08:08:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:40 INFO - 'PWD': '/builds/slave/test', 08:08:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:40 INFO - 'RUST_BACKTRACE': 'full', 08:08:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:08:40 INFO - 'SHELL': '/bin/bash', 08:08:40 INFO - 'SHLVL': '1', 08:08:40 INFO - 'TERM': 'linux', 08:08:40 INFO - 'TMOUT': '86400', 08:08:40 INFO - 'USER': 'cltbld', 08:08:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:40 INFO - '_': '/tools/buildbot/bin/python'} 08:08:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:08:40 INFO - mozversion application_buildid: 20171002130023 08:08:40 INFO - mozversion application_changeset: 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 08:08:40 INFO - mozversion application_display_name: Firefox 08:08:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:40 INFO - mozversion application_name: Firefox 08:08:40 INFO - mozversion application_remotingname: firefox 08:08:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:08:40 INFO - mozversion application_vendor: Mozilla 08:08:40 INFO - mozversion application_version: 57.0 08:08:40 INFO - mozversion platform_buildid: 20171002130023 08:08:40 INFO - mozversion platform_changeset: 1c9c05f5e5bd073187b2d16e0f87438bd730d2a2 08:08:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:08:40 INFO - mozversion platform_version: 57.0 08:08:40 INFO - using testdate: 1506956920 08:08:40 INFO - actual date: 1506956920 08:08:40 INFO - starting webserver on 'localhost:51184' 08:08:40 INFO - SUITE-START | Running 2 tests 08:08:40 INFO - TEST-START | dromaeo_css 08:08:40 INFO - Initialising browser for dromaeo_css test... 08:08:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51184/getInfo.html -profile /tmp/tmpHT5GKJ/profile 08:08:40 INFO - TEST-INFO | started process 27190 (/builds/slave/test/build/application/firefox/firefox http://localhost:51184/getInfo.html) 08:08:45 INFO - TEST-INFO | 27190: exit 0 08:08:45 INFO - Browser initialized. 08:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:45 INFO - Using env: {'DISPLAY': ':0', 08:08:45 INFO - 'HOME': '/home/cltbld', 08:08:45 INFO - 'JSGC_DISABLE_POISONING': '1', 08:08:45 INFO - 'LANG': 'en_US.UTF-8', 08:08:45 INFO - 'LANGUAGE': 'en_US:en', 08:08:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:08:45 INFO - 'LOGNAME': 'cltbld', 08:08:45 INFO - 'MAIL': '/var/mail/cltbld', 08:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:45 INFO - 'MOZ_CRASHREPORTER': '1', 08:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:08:45 INFO - 'MOZ_NO_REMOTE': '1', 08:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:45 INFO - 'NO_EM_RESTART': '1', 08:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:45 INFO - 'PWD': '/builds/slave/test', 08:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:45 INFO - 'RUST_BACKTRACE': 'full', 08:08:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:08:45 INFO - 'SHELL': '/bin/bash', 08:08:45 INFO - 'SHLVL': '1', 08:08:45 INFO - 'TERM': 'linux', 08:08:45 INFO - 'TMOUT': '86400', 08:08:45 INFO - 'USER': 'cltbld', 08:08:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:45 INFO - '_': '/tools/buildbot/bin/python'} 08:08:45 INFO - TEST-INFO | started process 27378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHT5GKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:46 INFO - PID 27378 | 08:08:46 INFO - PID 27378 | (/builds/slave/test/build/application/firefox/firefox:27427): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:08:46 INFO - PID 27378 | 08:08:56 INFO - PID 27378 | RSS: Main: 143867904 08:08:56 INFO - PID 27378 | 08:11:53 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51184/tests/dromaeo/cssquery-ext.html) 08:11:54 INFO - PID 27378 | RSS: Main: 145375232 08:11:54 INFO - PID 27378 | 08:14:56 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-ext.html (next: http://localhost:51184/tests/dromaeo/cssquery-jquery.html) 08:14:56 INFO - PID 27378 | RSS: Main: 145690624 08:14:56 INFO - PID 27378 | 08:17:58 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51184/tests/dromaeo/cssquery-mootools.html) 08:17:58 INFO - PID 27378 | RSS: Main: 146214912 08:17:58 INFO - PID 27378 | 08:21:00 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51184/tests/dromaeo/cssquery-prototype.html) 08:21:00 INFO - PID 27378 | RSS: Main: 146644992 08:21:00 INFO - PID 27378 | 08:24:03 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51184/tests/dromaeo/cssquery-yui.html) 08:24:04 INFO - PID 27378 | RSS: Main: 147746816 08:24:04 INFO - PID 27378 | 08:27:05 INFO - PID 27378 | Cycle 1(1): loaded http://localhost:51184/tests/dromaeo/cssquery-yui.html (next: http://localhost:51184/tests/dromaeo/cssquery-dojo.html) 08:27:06 INFO - PID 27378 | RSS: Main: 150151168 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | __start_tp_report 08:27:06 INFO - PID 27378 | _x_x_mozilla_page_load 08:27:06 INFO - PID 27378 | _x_x_mozilla_page_load_details 08:27:06 INFO - PID 27378 | |i|pagename|runs| 08:27:06 INFO - PID 27378 | |0;dojo.html;4027.416024676421;4031.9193616127677;4038.717289789716;4039.6970227232946;4056.6551843093334;6454.612723236609;6467.70895309711;6522.641254730988;6622.6357550334715;6637.203535575732;6435.485161187105;6478.838029049276;6505.284418713938;6529.967350163254;6550.705218265178;5823.330317013534;5829.5919285650025;5833.824985250428;5844.152597873306;5850.765969361241;5847.941520584804;5866.677332746697;5940.2277703898435;5949.5537834662355;5968.761249550034;5890.469857712805;5899.056151015839;5908.084246941731;5909.497692696126;5913.113033045035;5787.652740835563;5881.176635271044;5886.264216972879;5892.263467066617;5913.290405151388;5908.350081491032;5916.645001299936;5918.615290006136;5925.08161235005;5925.674087925162;6463.74145034198;6487.6756162191705;6493.642849643268;6584.30864759203;6587.3083326250535;6947.478939079539;7037.120359955005;7071.717131314741;7121;7124.073870396867;7148.892766608505;7156.499045066847;7164.605946672931;7171.497995140342;7175.533590316612;6387.1377364055725;6480.773172938924;6501.252355979028;6591.802245932582;6621.536492445531;7242.891356629655;7253.927460725431;7313.524620899624;7375.594342311224;7379.8155046124275;7002.894956575656;7009.299070093052;7091.432685385157;7103.822404439827;7111.431085513146;7021.22766495685;7139.143302803697;7172.713091476283;7235.602041887747;7245.492815502969;6895.138107736533;6941.34057264559;6946.409555187764;6970.128733908262;7003.26465721092;6946.861062778716;6986.965065174743;7012.0533727947095;7023.33278338557;7026.543274687129;5082.923756143661;5120.513551212629;5151.613628977767;5155.716435596003;5176;4617.561331673485;4679.251319788886;4710.599599034052;4711.599514041345;4752.500987396343;6649.767258146038;6663.500237482208;6684.565503242274;6693.966530167416;6760.966195168992;7002.649867506604;7112.964435177791;7119.323664251888;7130.465215108888;7132.928670713331;6595.8021259362295;6628.204615446178;6634.900476492857;6647.501437392215;6715.46276297895;5775.480206781326;5828;5866.178734977107;5872.530197584183;5880.059190529495;7384.630768461556;7393.371563417169;7464.962675186698;7466.775996720107;7487.775366739006;6930.410915072275;7016.5790052597;7097.396721278646;7111;7119.110111236096;7382.114146302478;7398.926010739824;7421.480496365202;7486.064241969754;7506.812329691801;7001.36987671112;7007.579545227302;7021.894671579828;7023.578585284899;7027.543209691354;6994.195667498303;7059.647017648994;7077.150741911004;7138.357547820721;7162.820929476805;6797;6818.318168183142;6881.4494840413645;6883.7590684325805;6913.93086069153;6852.074969879002;6862.279460656759;6913.585184888922;6919.930800691928;6925.82685432848;6760.695768690519;6810.523263371715;6831.726730930906;6852.314768523108;6858.828529286808;6812.65936703153;6892.862142757217;6894.517383783087;6968.163820341591;7020.297970203143;6624.701888414937;6708.530402871947;6723.966380168068;6788.4569234462115;6796.592204467748 08:27:06 INFO - PID 27378 | |1;ext.html;988.901109889011;990.3265779270098;1015.9339642923211;1041.4636462221952;1045.033344156655;48935.75532122339;49176;49619.25571116436;49706;49862.50137498624;49986;50921;50995;51006.95972161119;51055.48944510554;8960.596773145207;9107.089291070874;9108.544572771369;9138.268938484905;9189.540522973857;8968;9085.909140908572;9120.361574689774;9128.361014728971;9140.725778226664;9168.724938251864;9187.219086377667;9192.264618830477;9218.262538996898;9219.631214751402;9082.318826088036;9112.453252804853;9119.088091190893;9165.816683666322;9171.128742769426;8943.06097859722;9043.954780226122;9072.138146876036;9081.091890810932;9090.409123406956;45279.547204527866;45458.77270613659;45698;45705.771471142434;45845;3971.940420893689;3994.800259986989;3998.5001874765653;4004.2391945530258;4010.3583426651594;36586.63413365885;36643.63356366429;36654.26691466182;36743.08142296437;36794;5710.857228569319;5808.767649294024;5862.794802181946;5865.736041878125;5867.471927526501;249394;249884;250195;250601;250796;55717.442825572034;56014.439855600926;56257;56427.71786141043;56651;59993.40006599965;60071;60273.09590356148;60296.39703602996;60311.889083881855;19423.223071076998;19454.124564394635;19493.61012779765;19542;19550;16108.838911610968;16143.434979775651;16158.596035099217;16168.919155404148;16174.676506469805;14529.636759081108;15059.397624094914;15081.321340539702;15102.093874367572;15266.542003739905;5624.91562626561;5848.4151584841175;5856.765729370863;5900.321463031721;5920.526357891358;1104.828751543512;1112.7885701716648;1131.332513816852;1135.0862555642786;1135.250734515216;26370.340741481617;26943.326416839736;27032.59451108235;27173.320666983087;27291.863540682567;1211.745533437988;1249.2254802022621;1249.5251804314485;1252.0484431831692;1265.2661456355293;14053.578392648236;14086.577402677936;14259.78610320846;14287;14516.491922782652;280686;285408;286665;286966;305688;66358;66455.33544664491;66647.66676166588;66830.33169668338;66982;1528.9311980960883;1548.8683461905864;1555.929983150761;1563.7107135180029;1572.701186774509;31061.8446907764;31177.220569485944;31623.683763162993;31768.04695859128;31914.52128218032;44578.77710611426;44685.55314446814;44896.32655510105;44908.550914490435;44988.10023799571;242482;243563;243639;244685;245008;38545;38648.80675596604;38846.6115338843;39099.02252443712;39455.80272098736;48425.27362089501;50840.745796270785;50903.236451453995;51036;51235.487645124565;36871.07822304464;36921.81539092287;37058.814705927376;37460.250794984495;37855.05362365963;36941;37005;37123.81438092792;37159.442608360354;37428.62571374251;44087.33868991904;44808.327875081246;44822.551774483145;44853.32720009268;45222.773886131676;35884.64115358813;36096.63903361038;36366.818165909004;36626.45060324044;36667.26665466729;26158.34604134912;26552.734472655025;26776.464470710867;26814.59778103291;26856.865715671298 08:27:06 INFO - PID 27378 | |2;jquery.html;618.4310434400351;636.3063194141325;638.4764493115647;638.688792324069;652.9967350163248;24204.515909681817;25062.248132556007;25205.36986575332;25345.619815702757;25399.74600253997;26231.868840655818;27015.594766078477;27022.45955080902;27056.59415108775;27123;6780.762673306435;6967.094277743886;6967.721291148348;6979.47653925955;6993.405560527362;6632.369924857155;6847.931520684804;6870.175578930535;6871.862562748742;6883.242843287235;6822.522423430361;6832.590044597315;6836.863262734742;6837.111175547172;6840.315968403144;6806.11520502334;6811.523193376465;6832.726690932406;6846.383825455708;6855.5886646801355;6321.841953951142;6335.904961425582;6350.333215012403;6376.426121649028;6389.968050159766;30561.23596910073;30606.846965765253;31355;31634.683653163633;31760.205994850083;2261.977380226193;2305.8501197422115;2314.5949458844802;2314.8148148148107;2318.976810231893;21206.363809085753;21665.45836354088;21817.890910545346;21858.453538661503;21885.12459501634;2601.505713914369;2608.3479130217447;2647.6822781266374;2661.560842460992;2670.5059563980726;146693;152568;153037;155973.2201338986;157447;16600.418985335455;17323.740143897852;17521.386751463637;17636.1181940905;17707.55731106707;27162.72837271602;27297.454050919267;27332.316692082855;27423.45153096967;27424;11260.94369528147;11434.599789007345;11542;11664.591739289084;11670.183087183816;10270.435126067989;10347.793044139074;10351.327163734484;10426.322289051188;10471.267011309288;10223.233257505717;10234.59061637541;10240.743981400525;10276.332038417628;10340.27618066728;3017.8491075446577;3077.446059709229;3084.46021946163;3151;3207.4066297734994;1037.4708898461838;1062.2139616683598;1064.9467526623637;1066.1896958311738;1079.9460026998618;21236.25673101434;21559;21879.67180492294;22226.222082227043;22267.109315627193;1126.7295848996346;1136.3920302638048;1141.4578075414279;1143.5940241214248;1144.753877916252;11586.246893951866;11831.526738930519;12148.75702485963;12161.209521381259;12221.755564888652;645767;647062;653617;668075;672447;131194.34402827924;131906.34046829704;132321;134598;138225;1263.8925691316158;1284.178125999361;1292.6509842342514;1295.78843781065;1302.8371453568304;19395.127219274884;19396.709049364552;19409.32067377635;19547.70678439796;19815.108320125917;63412;65267.34732652613;65350.673246633465;65407.67296163679;66897.33102669106;81410.5929470349;81961;82406;82897.58551207205;83170.58414707887;15889.761653575437;16115.435959741353;16311.510654680378;16320.265588048329;16337.918310408371;23742.881285593463;24447.51104977926;24512.264632061066;24781.380465487786;24899.87550062238;19923.900380498006;20087.59824803525;20189.49526261855;20407.87756673338;20509.89745051325;17770.466885993443;18114.909425452788;18266;18413.07934603291;18502;20623.690644640043;20883.895580522;20891.895540522808;20986.2654807081;20993.790062099793;15695.450659226872;15773.44792932242;15776.290066946785;15810.7628385572;15879.761803572725;19506.122224499646;19841.30555430553;19853.205871764967;20000.59998800045;20063.197472100954 08:27:06 INFO - PID 27378 | |3;mootools.html;1417.1638733147445;1438.863307985741;1446.3419144289348;1462.3565631122299;1498.2883130513005;14889.404423823047;15570.922145389271;17867.910660446694;18608.441746747587;18630.44108676742;18040.909795451003;18162.09189540521;18196.45410637683;18227.54431139219;18263;3010.382871511346;3075.538669199627;3123.141136187544;3127.7497800176047;3135.0281412762115;3013.4123845850067;3030.4545181867256;3033.1507177990197;3061.0969763919697;3061.540768884674;3074.677158898317;3087.6603573606885;3133.8276394798277;3146.8269245191505;3159.3523327717876;2992.251937015746;3030.4242193983073;3057.8929737459193;3059.174023013796;3062.5865508156335;2925.824450532975;2947.9263018424494;2966.7329940305262;2971.895983640584;2972.7175918287944;17083.40208092711;17227.48317550463;17305.048222347767;17337.739933901;17370.739438908426;8557.229849313591;8879.733607991771;8918.55407229636;8941.46351218929;8955.462672239686;5509.559235261169;5650.943490565124;5685.829425117253;5695.316562012544;5785.305763308388;2177.9564408711894;2185.0822654485155;2185.344396681005;2194.2429861697688;2221.222572099752;32056.03831885047;32162.356752865046;32260.677393226;32382.190445238823;32421.837890810395;7303.744368947061;7356.411487081021;7556.2443755624;7655.387568994467;7685.961570192113;21017.474563136046;21098.156073756876;21108.894455527625;21156.47108822261;21182.046807893683;7831.2560306770765;8623.655053797904;8780.385373023826;8803.515806630698;8854.86717699235;6761.492888033417;7353.411727061823;8228.259456648811;8229.382796290301;8244.958775206085;6262.968685156545;6320.367963203643;6384.648844313608;6411.839704007437;6480;1812.130177514774;1831.6428296482325;1842.7512285841508;1863.506170864722;1887.2451019592;990.6532713550343;994.1649014827435;1002.0630710285906;1011.1859952738116;1026;8561.874915655866;8588.055313915589;8630.309575233967;8728.345374096842;8813.25087367568;808.1514409869731;813.5484805932646;815.6615004773072;817.0685418622775;821.4988856797349;4988.55103040728;5013.799448022039;5088.745562721849;5098.541131298127;5128.871778205575;25581.104661336765;25960;26673.33316667099;26683.73316266851;26749.598756018677;26365;26413.603795943076;26455.735442645328;26842;26946.86526567394;12211.328376939353;12650.936745316214;12723.427445764963;12736.490540378467;12943.935280323727;9397.530123493934;9419.529023548932;9502.239820814457;9531.285153613368;9631.422114673142;22066.44833879166;22086.88956555207;22383.32850014502;22520.887395562917;22937.770622293563;23564.528709426057;23750.762492374855;23801.285961421185;23955.640665390383;23959.76040239645;12899.097063205485;13035.217886926815;13236.669083272995;13260.668483287995;13264.469421223042;16098.678026439171;16156.838431615533;16273.267702953632;16338.836611633731;16389.83610163883;12211.450484728386;12567.245965242115;12728.809067863804;12825.03812214069;12830.29433381173;12186.451609677408;12345.444454999368;12525.185862918881;12600.936995314965;12656.810147847606;10038.799224015625;10214.182865370902;10229.335093218917;10231.539580719034;10241;8138.145494722969;8191.713290034821;8281.29608983243;8330.875036874331;8375;7643.617819109134;7758.534487930742;7790.9220907790195;7819.296263336327;7861.449698521277 08:27:06 INFO - PID 27378 | |4;prototype.html;523.1707743226985;550.4660479335043;564.5709260961668;570.5780203423468;573.3607028163597;6350.142730731356;6371.331010243927;6393.552451328409;6417.486601071914;6468.32082631324;6241.906371404432;6257.155284036665;6321.8620648283295;6323.652199129057;6372.904406433907;5095.388553373591;5147.897042059157;5174.66364686296;5200.583953283747;5205.27126202332;5068.4424713281505;5075.796968121271;5122.6926384416865;5215.530602245797;5244.475552444763;4880.658353915227;5032.270320803481;5044.747762611854;5093.516115968977;5177.741112944356;4982.451930287683;5003.749812509378;5067;5075.467075957008;5090.796368145269;4533.639908027579;4581.931271030937;4583.404157459542;4606.262997920317;4614.500287406573;6155.784547540815;6198.504119670461;6204.022069406665;6252.968735156341;6305.675808080308;5870.471657550841;5939.2575928009;5954.732037058299;5959.679232556406;5971.4327138921735;6592.439642630382;6639.668016599151;6762.256151823295;6786.558873673245;6797.728090876359;5009.298698182258;5061.620378471629;5083.745812709387;5084.618653600958;5091.719955402451;6842.828929276759;6845.14435695538;6866.622335771531;6945.305469453015;7016.5790052597;5205.219217117463;5209.348831396075;5221.164613661796;5223.817166399233;5250.711210883438;5251.448597897166;5276;5302.310699609026;5305.867353316121;5379.811706590251;5874.647521148745;5928.199693041471;5931.73307201177;5936.910946335808;5950.494207992283;6738.629375384401;6788.490863185182;6791.117154769849;6795.932040679629;6833.111695479556;1850.4911149433744;1851.8055604161639;1857.4891904726308;1858.7118996555555;1862.348178137641;1253.7743206222967;1281.6923938254752;1296.1445446005591;1299.1620404839016;1314.6524812067516;6448.193975753031;6475.287718350977;6477.093206951031;6489.2212934447225;6564.835879102965;6255.937440625627;6705.228898676714;6745.5952642841585;6806.18325800907;6819.693113809891;6308.684565771785;6383.808485745435;6454.709538070798;6481.245470674944;6517.934820651828;3602.9099272518397;3638.6361363863402;3663.3955397359136;3665.890023299305;3666.834992425347;7152.4278057755255;7161.283871612901;7216;7279.41764658826;7320.304571065741;6852.657367131624;6891.414229790524;6976.5465244758925;7077.610731409719;7097.9645101775195;7124.5725256484775;7158.2841715829045;7182.850743881058;7215.278472152848;7242.587695399452;6749.291324410866;6754.290799466182;6772.52592318533;6772.830679233059;6893.75871844483;6674.6662666865495;6706.899396509154;6715.697793599397;6786.660666966731;6822.454203663596;7163.531476047502;7259.382952449101;7272.418206543358;7277.745278915212;7301.634918254173;5216.37403511581;5267.9736601316745;5280.498352656491;5292.470752924677;5296.682199068068;6569.540132190701;6764.661766911537;6792.558483698544;6892.758753443605;6979.6859141337745;6501.122348482894;6592.80221593353;6611.30581288977;6674.094540512622;6686;6579.506537009648;6611.834704132435;6667.766628167991;6711.697973591103;6755.831104222434;6595.9105354680405;6612.603243805387;6640.203175618956;6700.162479690039;6703.3296670332575;6622.139121914313;6706.6646667665445;6752.426043786333;6768.886312296202;6787.966060169668;6492.480601551959;6523.151990241238;6544.312847150981;6578.703958321791;6591.8022459324375 08:27:06 INFO - PID 27378 | |5;yui.html;985.2758222706314;1015.3856916565477;1016.2682868334797;1031.5512751952897;1040.3393844908483;19089.904550477244;19389.12748926298;19531.5117122072;19545.902270488663;19562.021898905034;19748.802511974875;20121.59756804863;20122.899385503053;20785;20978.055987480562;1079.8434227037076;1099.6865893220433;1100.2683215661616;1103.2387652519776;1104.0780947908465;1070.5022164693416;1113.6603335982522;1116.6147679050714;1119.4458742922266;1119.9328040317566;1167.0721776187952;1182.5033485935885;1183.9526418943233;1183.9526418943233;1185.6798664360617;1157.2477889371892;1162.2910024884814;1163.2555164694602;1164.1327211227647;1164.9126315526369;851.8296340731816;853.5433543054498;855.1662129423825;860.5095095795399;860.8966923969164;20775.584488310302;21280.255191068238;21330.14679412837;21403.67894481584;22486.775132248633;24242.39394015146;24265.757342426525;24813.25560233196;24915.50168996628;24934.127305544218;17861.553461163447;18187.727184092248;18224;18284;18375.08124593765;4207.284761590507;4262.509811371701;4270.210011147948;4271.765052922088;4274.850380236708;163408;165344;165404.9999999988;166647.1667641666;166664;18237.361692340703;18593.675790526184;18594.721079183822;18599.256029758657;18628.627427451374;34430.13924651904;35105.1223719409;35301;35332.64667353345;35385.82307088448;9565.330426870192;9669.226461883032;9729.4648794317;9734.707958761248;9773.706788796348;4780.521947805261;4851.587615052689;4861.927071093936;4866.367372241657;4869.342638743795;6265.216847894013;6294.874102517924;6308.369163083747;6319.304876463585;6331.65478734266;1149.48273277024;1151.7235863392725;1176.129664048598;1177.128924595793;1178.640514643025;769.5844244108118;783.7883771381695;788.4480863395646;801.30686955784;801.8235988082729;13611.523596674268;13917.443302267999;14249.287535623178;14527.491537796126;14808.629784255265;782.0927723840318;790.5019837502451;792.025808255837;794.85692575337;798.4331124901269;6167.414095660905;6235.376462353728;6265.248170219603;6288.622682639057;6458.095866578683;153173;156336;157254.21372893063;157920;162373;136834.31582842022;137005;137451;138011.30994345166;144352.27823860812;114672;115490.4225478884;115960.42019789846;117949;122031.38984305199;11794.289827975068;12145.514179433078;12146.696332591757;12207.694807629525;12489.31308778026;58567.4143258579;59180.40819591921;59410.108848368174;59897.40102598918;60298.698506507186;74016.2598374031;74100.62949685217;74151;75514.24485755072;76378.23621763711;17071.573210669834;17508.037057961934;17851.73222401691;18141.183646735666;18152.90923545374;19894.10476528531;20512.17951281932;20611.896940515202;20817.89591052035;20860.68708969336;18895;18943.242270309034;18989.14548845333;19070.7139392912;19226.32707855218;18267;18275.26898924028;18300.633987319914;18499.075046247905;18586.907065465126;18640.34758783436;18673.439796806117;18702.438926831674;18741.156647950604;18936.242550297833;13642.522511712043;13987;13998.650033749238;14031.789523157366;14180.929095354457;13778.793318100437;13810.171389716648;13921.860781392057;13932.79100813509;14086.366113524711 08:27:06 INFO - PID 27378 | __end_tp_report 08:27:06 INFO - PID 27378 | __start_cc_report 08:27:06 INFO - PID 27378 | _x_x_mozilla_cycle_collect,253 08:27:06 INFO - PID 27378 | __end_cc_report 08:27:06 INFO - PID 27378 | __startTimestamp1506958026083__endTimestamp 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | ------- Summary: start ------- 08:27:06 INFO - PID 27378 | Number of tests: 6 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#0] dojo.html Cycles:165 Average:6534.82 Median:6810.52 stddev:778.01 (11.4%) stddev-sans-first:755.12 08:27:06 INFO - PID 27378 | Values: 4027.4 4031.9 4038.7 4039.7 4056.7 6454.6 6467.7 6522.6 6622.6 6637.2 6435.5 6478.8 6505.3 6530.0 6550.7 5823.3 5829.6 5833.8 5844.2 5850.8 5847.9 5866.7 5940.2 5949.6 5968.8 5890.5 5899.1 5908.1 5909.5 5913.1 5787.7 5881.2 5886.3 5892.3 5913.3 5908.4 5916.6 5918.6 5925.1 5925.7 6463.7 6487.7 6493.6 6584.3 6587.3 6947.5 7037.1 7071.7 7121.0 7124.1 7148.9 7156.5 7164.6 7171.5 7175.5 6387.1 6480.8 6501.3 6591.8 6621.5 7242.9 7253.9 7313.5 7375.6 7379.8 7002.9 7009.3 7091.4 7103.8 7111.4 7021.2 7139.1 7172.7 7235.6 7245.5 6895.1 6941.3 6946.4 6970.1 7003.3 6946.9 6987.0 7012.1 7023.3 7026.5 5082.9 5120.5 5151.6 5155.7 5176.0 4617.6 4679.3 4710.6 4711.6 4752.5 6649.8 6663.5 6684.6 6694.0 6761.0 7002.6 7113.0 7119.3 7130.5 7132.9 6595.8 6628.2 6634.9 6647.5 6715.5 5775.5 5828.0 5866.2 5872.5 5880.1 7384.6 7393.4 7465.0 7466.8 7487.8 6930.4 7016.6 7097.4 7111.0 7119.1 7382.1 7398.9 7421.5 7486.1 7506.8 7001.4 7007.6 7021.9 7023.6 7027.5 6994.2 7059.6 7077.2 7138.4 7162.8 6797.0 6818.3 6881.4 6883.8 6913.9 6852.1 6862.3 6913.6 6919.9 6925.8 6760.7 6810.5 6831.7 6852.3 6858.8 6812.7 6892.9 6894.5 6968.2 7020.3 6624.7 6708.5 6724.0 6788.5 6796.6 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#1] ext.html Cycles:180 Average:45959.50 Median:38972.82 stddev:67993.28 (174.5%) stddev-sans-first:68100.17 08:27:06 INFO - PID 27378 | Values: 988.9 990.3 1015.9 1041.5 1045.0 48935.8 49176.0 49619.3 49706.0 49862.5 49986.0 50921.0 50995.0 51007.0 51055.5 8960.6 9107.1 9108.5 9138.3 9189.5 8968.0 9085.9 9120.4 9128.4 9140.7 9168.7 9187.2 9192.3 9218.3 9219.6 9082.3 9112.5 9119.1 9165.8 9171.1 8943.1 9044.0 9072.1 9081.1 9090.4 45279.5 45458.8 45698.0 45705.8 45845.0 3971.9 3994.8 3998.5 4004.2 4010.4 36586.6 36643.6 36654.3 36743.1 36794.0 5710.9 5808.8 5862.8 5865.7 5867.5 249394.0 249884.0 250195.0 250601.0 250796.0 55717.4 56014.4 56257.0 56427.7 56651.0 59993.4 60071.0 60273.1 60296.4 60311.9 19423.2 19454.1 19493.6 19542.0 19550.0 16108.8 16143.4 16158.6 16168.9 16174.7 14529.6 15059.4 15081.3 15102.1 15266.5 5624.9 5848.4 5856.8 5900.3 5920.5 1104.8 1112.8 1131.3 1135.1 1135.3 26370.3 26943.3 27032.6 27173.3 27291.9 1211.7 1249.2 1249.5 1252.0 1265.3 14053.6 14086.6 14259.8 14287.0 14516.5 280686.0 285408.0 286665.0 286966.0 305688.0 66358.0 66455.3 66647.7 66830.3 66982.0 1528.9 1548.9 1555.9 1563.7 1572.7 31061.8 31177.2 31623.7 31768.0 31914.5 44578.8 44685.6 44896.3 44908.6 44988.1 242482.0 243563.0 243639.0 244685.0 245008.0 38545.0 38648.8 38846.6 39099.0 39455.8 48425.3 50840.7 50903.2 51036.0 51235.5 36871.1 36921.8 37058.8 37460.3 37855.1 36941.0 37005.0 37123.8 37159.4 37428.6 44087.3 44808.3 44822.6 44853.3 45222.8 35884.6 36096.6 36366.8 36626.5 36667.3 26158.3 26552.7 26776.5 26814.6 26856.9 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#2] jquery.html Cycles:180 Average:41899.34 Median:21869.06 stddev:109543.55 (500.9%) stddev-sans-first:109807.00 08:27:06 INFO - PID 27378 | Values: 618.4 636.3 638.5 638.7 653.0 24204.5 25062.2 25205.4 25345.6 25399.7 26231.9 27015.6 27022.5 27056.6 27123.0 6780.8 6967.1 6967.7 6979.5 6993.4 6632.4 6847.9 6870.2 6871.9 6883.2 6822.5 6832.6 6836.9 6837.1 6840.3 6806.1 6811.5 6832.7 6846.4 6855.6 6321.8 6335.9 6350.3 6376.4 6390.0 30561.2 30606.8 31355.0 31634.7 31760.2 2262.0 2305.9 2314.6 2314.8 2319.0 21206.4 21665.5 21817.9 21858.5 21885.1 2601.5 2608.3 2647.7 2661.6 2670.5 146693.0 152568.0 153037.0 155973.2 157447.0 16600.4 17323.7 17521.4 17636.1 17707.6 27162.7 27297.5 27332.3 27423.5 27424.0 11260.9 11434.6 11542.0 11664.6 11670.2 10270.4 10347.8 10351.3 10426.3 10471.3 10223.2 10234.6 10240.7 10276.3 10340.3 3017.8 3077.4 3084.5 3151.0 3207.4 1037.5 1062.2 1064.9 1066.2 1079.9 21236.3 21559.0 21879.7 22226.2 22267.1 1126.7 1136.4 1141.5 1143.6 1144.8 11586.2 11831.5 12148.8 12161.2 12221.8 645767.0 647062.0 653617.0 668075.0 672447.0 131194.3 131906.3 132321.0 134598.0 138225.0 1263.9 1284.2 1292.7 1295.8 1302.8 19395.1 19396.7 19409.3 19547.7 19815.1 63412.0 65267.3 65350.7 65407.7 66897.3 81410.6 81961.0 82406.0 82897.6 83170.6 15889.8 16115.4 16311.5 16320.3 16337.9 23742.9 24447.5 24512.3 24781.4 24899.9 19923.9 20087.6 20189.5 20407.9 20509.9 17770.5 18114.9 18266.0 18413.1 18502.0 20623.7 20883.9 20891.9 20986.3 20993.8 15695.5 15773.4 15776.3 15810.8 15879.8 19506.1 19841.3 19853.2 20000.6 20063.2 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#3] mootools.html Cycles:180 Average:10804.58 Median:2969.31 stddev:8210.50 (276.5%) stddev-sans-first:8203.24 08:27:06 INFO - PID 27378 | Values: 1417.2 1438.9 1446.3 1462.4 1498.3 14889.4 15570.9 17867.9 18608.4 18630.4 18040.9 18162.1 18196.5 18227.5 18263.0 3010.4 3075.5 3123.1 3127.7 3135.0 3013.4 3030.5 3033.2 3061.1 3061.5 3074.7 3087.7 3133.8 3146.8 3159.4 2992.3 3030.4 3057.9 3059.2 3062.6 2925.8 2947.9 2966.7 2971.9 2972.7 17083.4 17227.5 17305.0 17337.7 17370.7 8557.2 8879.7 8918.6 8941.5 8955.5 5509.6 5650.9 5685.8 5695.3 5785.3 2178.0 2185.1 2185.3 2194.2 2221.2 32056.0 32162.4 32260.7 32382.2 32421.8 7303.7 7356.4 7556.2 7655.4 7686.0 21017.5 21098.2 21108.9 21156.5 21182.0 7831.3 8623.7 8780.4 8803.5 8854.9 6761.5 7353.4 8228.3 8229.4 8245.0 6263.0 6320.4 6384.6 6411.8 6480.0 1812.1 1831.6 1842.8 1863.5 1887.2 990.7 994.2 1002.1 1011.2 1026.0 8561.9 8588.1 8630.3 8728.3 8813.3 808.2 813.5 815.7 817.1 821.5 4988.6 5013.8 5088.7 5098.5 5128.9 25581.1 25960.0 26673.3 26683.7 26749.6 26365.0 26413.6 26455.7 26842.0 26946.9 12211.3 12650.9 12723.4 12736.5 12943.9 9397.5 9419.5 9502.2 9531.3 9631.4 22066.4 22086.9 22383.3 22520.9 22937.8 23564.5 23750.8 23801.3 23955.6 23959.8 12899.1 13035.2 13236.7 13260.7 13264.5 16098.7 16156.8 16273.3 16338.8 16389.8 12211.5 12567.2 12728.8 12825.0 12830.3 12186.5 12345.4 12525.2 12600.9 12656.8 10038.8 10214.2 10229.3 10231.5 10241.0 8138.1 8191.7 8281.3 8330.9 8375.0 7643.6 7758.5 7790.9 7819.3 7861.4 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#4] prototype.html Cycles:180 Average:5726.61 Median:6405.52 stddev:1604.81 (25.1%) stddev-sans-first:1561.06 08:27:06 INFO - PID 27378 | Values: 523.2 550.5 564.6 570.6 573.4 6350.1 6371.3 6393.6 6417.5 6468.3 6241.9 6257.2 6321.9 6323.7 6372.9 5095.4 5147.9 5174.7 5200.6 5205.3 5068.4 5075.8 5122.7 5215.5 5244.5 4880.7 5032.3 5044.7 5093.5 5177.7 4982.5 5003.7 5067.0 5075.5 5090.8 4533.6 4581.9 4583.4 4606.3 4614.5 6155.8 6198.5 6204.0 6253.0 6305.7 5870.5 5939.3 5954.7 5959.7 5971.4 6592.4 6639.7 6762.3 6786.6 6797.7 5009.3 5061.6 5083.7 5084.6 5091.7 6842.8 6845.1 6866.6 6945.3 7016.6 5205.2 5209.3 5221.2 5223.8 5250.7 5251.4 5276.0 5302.3 5305.9 5379.8 5874.6 5928.2 5931.7 5936.9 5950.5 6738.6 6788.5 6791.1 6795.9 6833.1 1850.5 1851.8 1857.5 1858.7 1862.3 1253.8 1281.7 1296.1 1299.2 1314.7 6448.2 6475.3 6477.1 6489.2 6564.8 6255.9 6705.2 6745.6 6806.2 6819.7 6308.7 6383.8 6454.7 6481.2 6517.9 3602.9 3638.6 3663.4 3665.9 3666.8 7152.4 7161.3 7216.0 7279.4 7320.3 6852.7 6891.4 6976.5 7077.6 7098.0 7124.6 7158.3 7182.9 7215.3 7242.6 6749.3 6754.3 6772.5 6772.8 6893.8 6674.7 6706.9 6715.7 6786.7 6822.5 7163.5 7259.4 7272.4 7277.7 7301.6 5216.4 5268.0 5280.5 5292.5 5296.7 6569.5 6764.7 6792.6 6892.8 6979.7 6501.1 6592.8 6611.3 6674.1 6686.0 6579.5 6611.8 6667.8 6711.7 6755.8 6595.9 6612.6 6640.2 6700.2 6703.3 6622.1 6706.7 6752.4 6768.9 6788.0 6492.5 6523.2 6544.3 6578.7 6591.8 08:27:06 INFO - PID 27378 | 08:27:06 INFO - PID 27378 | [#5] yui.html Cycles:180 Average:29447.05 Median:18687.94 stddev:44097.92 (236.0%) stddev-sans-first:44169.84 08:27:06 INFO - PID 27378 | Values: 985.3 1015.4 1016.3 1031.6 1040.3 19089.9 19389.1 19531.5 19545.9 19562.0 19748.8 20121.6 20122.9 20785.0 20978.1 1079.8 1099.7 1100.3 1103.2 1104.1 1070.5 1113.7 1116.6 1119.4 1119.9 1167.1 1182.5 1184.0 1184.0 1185.7 1157.2 1162.3 1163.3 1164.1 1164.9 851.8 853.5 855.2 860.5 860.9 20775.6 21280.3 21330.1 21403.7 22486.8 24242.4 24265.8 24813.3 24915.5 24934.1 17861.6 18187.7 18224.0 18284.0 18375.1 4207.3 4262.5 4270.2 4271.8 4274.9 163408.0 165344.0 165405.0 166647.2 166664.0 18237.4 18593.7 18594.7 18599.3 18628.6 34430.1 35105.1 35301.0 35332.6 35385.8 9565.3 9669.2 9729.5 9734.7 9773.7 4780.5 4851.6 4861.9 4866.4 4869.3 6265.2 6294.9 6308.4 6319.3 6331.7 1149.5 1151.7 1176.1 1177.1 1178.6 769.6 783.8 788.4 801.3 801.8 13611.5 13917.4 14249.3 14527.5 14808.6 782.1 790.5 792.0 794.9 798.4 6167.4 6235.4 6265.2 6288.6 6458.1 153173.0 156336.0 157254.2 157920.0 162373.0 136834.3 137005.0 137451.0 138011.3 144352.3 114672.0 115490.4 115960.4 117949.0 122031.4 11794.3 12145.5 12146.7 12207.7 12489.3 58567.4 59180.4 59410.1 59897.4 60298.7 74016.3 74100.6 74151.0 75514.2 76378.2 17071.6 17508.0 17851.7 18141.2 18152.9 19894.1 20512.2 20611.9 20817.9 20860.7 18895.0 18943.2 18989.1 19070.7 19226.3 18267.0 18275.3 18300.6 18499.1 18586.9 18640.3 18673.4 18702.4 18741.2 18936.2 13642.5 13987.0 13998.7 14031.8 14180.9 13778.8 13810.2 13921.9 13932.8 14086.4 08:27:06 INFO - PID 27378 | -------- Summary: end -------- 08:27:06 INFO - PID 27378 | 08:27:06 INFO - TEST-INFO | 27378: exit 0 08:27:06 INFO - TEST-OK | dromaeo_css | took 1106132ms 08:27:06 INFO - TEST-START | kraken 08:27:06 INFO - Initialising browser for kraken test... 08:27:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51184/getInfo.html -profile /tmp/tmpuzQI3V/profile 08:27:06 INFO - TEST-INFO | started process 27744 (/builds/slave/test/build/application/firefox/firefox http://localhost:51184/getInfo.html) 08:27:11 INFO - TEST-INFO | 27744: exit 0 08:27:11 INFO - Browser initialized. 08:27:11 INFO - Running cycle 1/1 for kraken test... 08:27:11 INFO - Using env: {'DISPLAY': ':0', 08:27:11 INFO - 'HOME': '/home/cltbld', 08:27:11 INFO - 'JSGC_DISABLE_POISONING': '1', 08:27:11 INFO - 'LANG': 'en_US.UTF-8', 08:27:11 INFO - 'LANGUAGE': 'en_US:en', 08:27:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:27:11 INFO - 'LOGNAME': 'cltbld', 08:27:11 INFO - 'MAIL': '/var/mail/cltbld', 08:27:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:27:11 INFO - 'MOZ_CRASHREPORTER': '1', 08:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:27:11 INFO - 'MOZ_NO_REMOTE': '1', 08:27:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:11 INFO - 'NO_EM_RESTART': '1', 08:27:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:11 INFO - 'PWD': '/builds/slave/test', 08:27:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:11 INFO - 'RUST_BACKTRACE': 'full', 08:27:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:27:11 INFO - 'SHELL': '/bin/bash', 08:27:11 INFO - 'SHLVL': '1', 08:27:11 INFO - 'TERM': 'linux', 08:27:11 INFO - 'TMOUT': '86400', 08:27:11 INFO - 'USER': 'cltbld', 08:27:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108', 08:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:11 INFO - '_': '/tools/buildbot/bin/python'} 08:27:11 INFO - TEST-INFO | started process 27937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuzQI3V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:12 INFO - PID 27937 | 08:27:12 INFO - PID 27937 | (/builds/slave/test/build/application/firefox/firefox:27985): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:27:12 INFO - PID 27937 | 08:27:22 INFO - PID 27937 | RSS: Main: 141307904 08:27:22 INFO - PID 27937 | 08:27:25 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51184/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:26 INFO - PID 27937 | RSS: Main: 148062208 08:27:26 INFO - PID 27937 | 08:27:28 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51184/tests/kraken/driver.html?testName=audio-dft) 08:27:29 INFO - PID 27937 | RSS: Main: 148754432 08:27:29 INFO - PID 27937 | 08:27:32 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51184/tests/kraken/driver.html?testName=audio-fft) 08:27:32 INFO - PID 27937 | RSS: Main: 150773760 08:27:32 INFO - PID 27937 | 08:27:34 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51184/tests/kraken/driver.html?testName=audio-oscillator) 08:27:35 INFO - PID 27937 | RSS: Main: 150618112 08:27:35 INFO - PID 27937 | 08:27:37 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:38 INFO - PID 27937 | RSS: Main: 150454272 08:27:38 INFO - PID 27937 | 08:27:41 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51184/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:41 INFO - PID 27937 | RSS: Main: 150097920 08:27:41 INFO - PID 27937 | 08:27:45 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51184/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:45 INFO - PID 27937 | RSS: Main: 149999616 08:27:45 INFO - PID 27937 | 08:27:48 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51184/tests/kraken/driver.html?testName=json-parse-financial) 08:27:49 INFO - PID 27937 | RSS: Main: 151375872 08:27:49 INFO - PID 27937 | 08:27:50 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:51 INFO - PID 27937 | RSS: Main: 151076864 08:27:51 INFO - PID 27937 | 08:27:53 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:53 INFO - PID 27937 | RSS: Main: 151224320 08:27:53 INFO - PID 27937 | 08:27:55 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:56 INFO - PID 27937 | RSS: Main: 148123648 08:27:56 INFO - PID 27937 | 08:27:58 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:59 INFO - PID 27937 | RSS: Main: 148344832 08:27:59 INFO - PID 27937 | 08:28:02 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:02 INFO - PID 27937 | RSS: Main: 149016576 08:28:02 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | Cycle 1(1): loaded http://localhost:51184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51184/tests/kraken/driver.html?testName=ai-astar) 08:28:04 INFO - PID 27937 | RSS: Main: 150401024 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | __start_tp_report 08:28:04 INFO - PID 27937 | _x_x_mozilla_page_load 08:28:04 INFO - PID 27937 | _x_x_mozilla_page_load_details 08:28:04 INFO - PID 27937 | |i|pagename|runs| 08:28:04 INFO - PID 27937 | |0;ai-astar;105;104;116;104;103;104;107;105;105;105 08:28:04 INFO - PID 27937 | |1;audio-beat-detection;114;111;114;111;111;117;115;113;113;152 08:28:04 INFO - PID 27937 | |2;audio-dft;162;164;162;163;163;162;162;163;160;162 08:28:04 INFO - PID 27937 | |3;audio-fft;73;73;74;74;74;72;73;81;75;74 08:28:04 INFO - PID 27937 | |4;audio-oscillator;77;77;77;76;76;86;77;78;78;78 08:28:04 INFO - PID 27937 | |5;imaging-gaussian-blur;114;113;109;113;111;115;111;114;114;110 08:28:04 INFO - PID 27937 | |6;imaging-darkroom;150;151;151;150;148;157;148;147;148;148 08:28:04 INFO - PID 27937 | |7;imaging-desaturate;94;95;94;94;95;94;94;94;95;94 08:28:04 INFO - PID 27937 | |8;json-parse-financial;44;43;47;46;43;47;41;46;42;42 08:28:04 INFO - PID 27937 | |9;json-stringify-tinderbox;39;39;41;39;38;39;39;38;39;39 08:28:04 INFO - PID 27937 | |10;stanford-crypto-aes;73;70;71;73;76;69;71;75;71;73 08:28:04 INFO - PID 27937 | |11;stanford-crypto-ccm;104;118;105;103;113;105;108;104;109;100 08:28:04 INFO - PID 27937 | |12;stanford-crypto-pbkdf2;153;151;158;160;155;157;164;154;153;150 08:28:04 INFO - PID 27937 | |13;stanford-crypto-sha256-iterative;61;59;60;59;63;57;68;58;66;59 08:28:04 INFO - PID 27937 | __end_tp_report 08:28:04 INFO - PID 27937 | __start_cc_report 08:28:04 INFO - PID 27937 | _x_x_mozilla_cycle_collect,681 08:28:04 INFO - PID 27937 | __end_cc_report 08:28:04 INFO - PID 27937 | __startTimestamp1506958084595__endTimestamp 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | ------- Summary: start ------- 08:28:04 INFO - PID 27937 | Number of tests: 14 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#0] ai-astar Cycles:10 Average:105.80 Median:105.00 stddev:3.74 (3.6%) stddev-sans-first:3.95 08:28:04 INFO - PID 27937 | Values: 105.0 104.0 116.0 104.0 103.0 104.0 107.0 105.0 105.0 105.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#1] audio-beat-detection Cycles:10 Average:117.10 Median:114.00 stddev:12.41 (10.9%) stddev-sans-first:13.12 08:28:04 INFO - PID 27937 | Values: 114.0 111.0 114.0 111.0 111.0 117.0 115.0 113.0 113.0 152.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 08:28:04 INFO - PID 27937 | Values: 162.0 164.0 162.0 163.0 163.0 162.0 162.0 163.0 160.0 162.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:2.50 (3.4%) stddev-sans-first:2.60 08:28:04 INFO - PID 27937 | Values: 73.0 73.0 74.0 74.0 74.0 72.0 73.0 81.0 75.0 74.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:77.50 stddev:2.91 (3.7%) stddev-sans-first:3.06 08:28:04 INFO - PID 27937 | Values: 77.0 77.0 77.0 76.0 76.0 86.0 77.0 78.0 78.0 78.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#5] imaging-gaussian-blur Cycles:10 Average:112.40 Median:113.50 stddev:2.01 (1.8%) stddev-sans-first:2.05 08:28:04 INFO - PID 27937 | Values: 114.0 113.0 109.0 113.0 111.0 115.0 111.0 114.0 114.0 110.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:2.90 (1.9%) stddev-sans-first:3.07 08:28:04 INFO - PID 27937 | Values: 150.0 151.0 151.0 150.0 148.0 157.0 148.0 147.0 148.0 148.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:28:04 INFO - PID 27937 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:45.00 stddev:2.23 (5.0%) stddev-sans-first:2.37 08:28:04 INFO - PID 27937 | Values: 44.0 43.0 47.0 46.0 43.0 47.0 41.0 46.0 42.0 42.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:0.82 (2.1%) stddev-sans-first:0.87 08:28:04 INFO - PID 27937 | Values: 39.0 39.0 41.0 39.0 38.0 39.0 39.0 38.0 39.0 39.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:73.00 stddev:2.20 (3.0%) stddev-sans-first:2.32 08:28:04 INFO - PID 27937 | Values: 73.0 70.0 71.0 73.0 76.0 69.0 71.0 75.0 71.0 73.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#11] stanford-crypto-ccm Cycles:10 Average:106.90 Median:106.50 stddev:5.30 (5.0%) stddev-sans-first:5.52 08:28:04 INFO - PID 27937 | Values: 104.0 118.0 105.0 103.0 113.0 105.0 108.0 104.0 109.0 100.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:4.30 (2.8%) stddev-sans-first:4.47 08:28:04 INFO - PID 27937 | Values: 153.0 151.0 158.0 160.0 155.0 157.0 164.0 154.0 153.0 150.0 08:28:04 INFO - PID 27937 | 08:28:04 INFO - PID 27937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:60.50 stddev:3.59 (5.9%) stddev-sans-first:3.81 08:28:04 INFO - PID 27937 | Values: 61.0 59.0 60.0 59.0 63.0 57.0 68.0 58.0 66.0 59.0 08:28:04 INFO - PID 27937 | -------- Summary: end -------- 08:28:04 INFO - PID 27937 | 08:28:05 INFO - PID 27937 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:28:05 INFO - TEST-INFO | 27937: exit 0 08:28:05 INFO - TEST-OK | kraken | took 58679ms 08:28:05 INFO - SUITE-END | took 1164s 08:28:05 INFO - Completed test suite (00:19:25) 08:28:05 INFO - javascript benchmark 08:28:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9436.835336146842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4027.416024676421, 4031.9193616127677, 4038.717289789716, 4039.6970227232946, 4056.6551843093334, 6454.612723236609, 6467.70895309711, 6522.641254730988, 6622.6357550334715, 6637.203535575732, 6435.485161187105, 6478.838029049276, 6505.284418713938, 6529.967350163254, 6550.705218265178, 5823.330317013534, 5829.5919285650025, 5833.824985250428, 5844.152597873306, 5850.765969361241, 5847.941520584804, 5866.677332746697, 5940.2277703898435, 5949.5537834662355, 5968.761249550034, 5890.469857712805, 5899.056151015839, 5908.084246941731, 5909.497692696126, 5913.113033045035, 5787.652740835563, 5881.176635271044, 5886.264216972879, 5892.263467066617, 5913.290405151388, 5908.350081491032, 5916.645001299936, 5918.615290006136, 5925.08161235005, 5925.674087925162, 6463.74145034198, 6487.6756162191705, 6493.642849643268, 6584.30864759203, 6587.3083326250535, 6947.478939079539, 7037.120359955005, 7071.717131314741, 7121.0, 7124.073870396867, 7148.892766608505, 7156.499045066847, 7164.605946672931, 7171.497995140342, 7175.533590316612, 6387.1377364055725, 6480.773172938924, 6501.252355979028, 6591.802245932582, 6621.536492445531, 7242.891356629655, 7253.927460725431, 7313.524620899624, 7375.594342311224, 7379.8155046124275, 7002.894956575656, 7009.299070093052, 7091.432685385157, 7103.822404439827, 7111.431085513146, 7021.22766495685, 7139.143302803697, 7172.713091476283, 7235.602041887747, 7245.492815502969, 6895.138107736533, 6941.34057264559, 6946.409555187764, 6970.128733908262, 7003.26465721092, 6946.861062778716, 6986.965065174743, 7012.0533727947095, 7023.33278338557, 7026.543274687129, 5082.923756143661, 5120.513551212629, 5151.613628977767, 5155.716435596003, 5176.0, 4617.561331673485, 4679.251319788886, 4710.599599034052, 4711.599514041345, 4752.500987396343, 6649.767258146038, 6663.500237482208, 6684.565503242274, 6693.966530167416, 6760.966195168992, 7002.649867506604, 7112.964435177791, 7119.323664251888, 7130.465215108888, 7132.928670713331, 6595.8021259362295, 6628.204615446178, 6634.900476492857, 6647.501437392215, 6715.46276297895, 5775.480206781326, 5828.0, 5866.178734977107, 5872.530197584183, 5880.059190529495, 7384.630768461556, 7393.371563417169, 7464.962675186698, 7466.775996720107, 7487.775366739006, 6930.410915072275, 7016.5790052597, 7097.396721278646, 7111.0, 7119.110111236096, 7382.114146302478, 7398.926010739824, 7421.480496365202, 7486.064241969754, 7506.812329691801, 7001.36987671112, 7007.579545227302, 7021.894671579828, 7023.578585284899, 7027.543209691354, 6994.195667498303, 7059.647017648994, 7077.150741911004, 7138.357547820721, 7162.820929476805, 6797.0, 6818.318168183142, 6881.4494840413645, 6883.7590684325805, 6913.93086069153, 6852.074969879002, 6862.279460656759, 6913.585184888922, 6919.930800691928, 6925.82685432848, 6760.695768690519, 6810.523263371715, 6831.726730930906, 6852.314768523108, 6858.828529286808, 6812.65936703153, 6892.862142757217, 6894.517383783087, 6968.163820341591, 7020.297970203143, 6624.701888414937, 6708.530402871947, 6723.966380168068, 6788.4569234462115, 6796.592204467748], "value": 6481.715964690445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.901109889011, 990.3265779270098, 1015.9339642923211, 1041.4636462221952, 1045.033344156655, 48935.75532122339, 49176.0, 49619.25571116436, 49706.0, 49862.50137498624, 49986.0, 50921.0, 50995.0, 51006.95972161119, 51055.48944510554, 8960.596773145207, 9107.089291070874, 9108.544572771369, 9138.268938484905, 9189.540522973857, 8968.0, 9085.909140908572, 9120.361574689774, 9128.361014728971, 9140.725778226664, 9168.724938251864, 9187.219086377667, 9192.264618830477, 9218.262538996898, 9219.631214751402, 9082.318826088036, 9112.453252804853, 9119.088091190893, 9165.816683666322, 9171.128742769426, 8943.06097859722, 9043.954780226122, 9072.138146876036, 9081.091890810932, 9090.409123406956, 45279.547204527866, 45458.77270613659, 45698.0, 45705.771471142434, 45845.0, 3971.940420893689, 3994.800259986989, 3998.5001874765653, 4004.2391945530258, 4010.3583426651594, 36586.63413365885, 36643.63356366429, 36654.26691466182, 36743.08142296437, 36794.0, 5710.857228569319, 5808.767649294024, 5862.794802181946, 5865.736041878125, 5867.471927526501, 249394.0, 249884.0, 250195.0, 250601.0, 250796.0, 55717.442825572034, 56014.439855600926, 56257.0, 56427.71786141043, 56651.0, 59993.40006599965, 60071.0, 60273.09590356148, 60296.39703602996, 60311.889083881855, 19423.223071076998, 19454.124564394635, 19493.61012779765, 19542.0, 19550.0, 16108.838911610968, 16143.434979775651, 16158.596035099217, 16168.919155404148, 16174.676506469805, 14529.636759081108, 15059.397624094914, 15081.321340539702, 15102.093874367572, 15266.542003739905, 5624.91562626561, 5848.4151584841175, 5856.765729370863, 5900.321463031721, 5920.526357891358, 1104.828751543512, 1112.7885701716648, 1131.332513816852, 1135.0862555642786, 1135.250734515216, 26370.340741481617, 26943.326416839736, 27032.59451108235, 27173.320666983087, 27291.863540682567, 1211.745533437988, 1249.2254802022621, 1249.5251804314485, 1252.0484431831692, 1265.2661456355293, 14053.578392648236, 14086.577402677936, 14259.78610320846, 14287.0, 14516.491922782652, 280686.0, 285408.0, 286665.0, 286966.0, 305688.0, 66358.0, 66455.33544664491, 66647.66676166588, 66830.33169668338, 66982.0, 1528.9311980960883, 1548.8683461905864, 1555.929983150761, 1563.7107135180029, 1572.701186774509, 31061.8446907764, 31177.220569485944, 31623.683763162993, 31768.04695859128, 31914.52128218032, 44578.77710611426, 44685.55314446814, 44896.32655510105, 44908.550914490435, 44988.10023799571, 242482.0, 243563.0, 243639.0, 244685.0, 245008.0, 38545.0, 38648.80675596604, 38846.6115338843, 39099.02252443712, 39455.80272098736, 48425.27362089501, 50840.745796270785, 50903.236451453995, 51036.0, 51235.487645124565, 36871.07822304464, 36921.81539092287, 37058.814705927376, 37460.250794984495, 37855.05362365963, 36941.0, 37005.0, 37123.81438092792, 37159.442608360354, 37428.62571374251, 44087.33868991904, 44808.327875081246, 44822.551774483145, 44853.32720009268, 45222.773886131676, 35884.64115358813, 36096.63903361038, 36366.818165909004, 36626.45060324044, 36667.26665466729, 26158.34604134912, 26552.734472655025, 26776.464470710867, 26814.59778103291, 26856.865715671298], "value": 20182.133094286393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.4310434400351, 636.3063194141325, 638.4764493115647, 638.688792324069, 652.9967350163248, 24204.515909681817, 25062.248132556007, 25205.36986575332, 25345.619815702757, 25399.74600253997, 26231.868840655818, 27015.594766078477, 27022.45955080902, 27056.59415108775, 27123.0, 6780.762673306435, 6967.094277743886, 6967.721291148348, 6979.47653925955, 6993.405560527362, 6632.369924857155, 6847.931520684804, 6870.175578930535, 6871.862562748742, 6883.242843287235, 6822.522423430361, 6832.590044597315, 6836.863262734742, 6837.111175547172, 6840.315968403144, 6806.11520502334, 6811.523193376465, 6832.726690932406, 6846.383825455708, 6855.5886646801355, 6321.841953951142, 6335.904961425582, 6350.333215012403, 6376.426121649028, 6389.968050159766, 30561.23596910073, 30606.846965765253, 31355.0, 31634.683653163633, 31760.205994850083, 2261.977380226193, 2305.8501197422115, 2314.5949458844802, 2314.8148148148107, 2318.976810231893, 21206.363809085753, 21665.45836354088, 21817.890910545346, 21858.453538661503, 21885.12459501634, 2601.505713914369, 2608.3479130217447, 2647.6822781266374, 2661.560842460992, 2670.5059563980726, 146693.0, 152568.0, 153037.0, 155973.2201338986, 157447.0, 16600.418985335455, 17323.740143897852, 17521.386751463637, 17636.1181940905, 17707.55731106707, 27162.72837271602, 27297.454050919267, 27332.316692082855, 27423.45153096967, 27424.0, 11260.94369528147, 11434.599789007345, 11542.0, 11664.591739289084, 11670.183087183816, 10270.435126067989, 10347.793044139074, 10351.327163734484, 10426.322289051188, 10471.267011309288, 10223.233257505717, 10234.59061637541, 10240.743981400525, 10276.332038417628, 10340.27618066728, 3017.8491075446577, 3077.446059709229, 3084.46021946163, 3151.0, 3207.4066297734994, 1037.4708898461838, 1062.2139616683598, 1064.9467526623637, 1066.1896958311738, 1079.9460026998618, 21236.25673101434, 21559.0, 21879.67180492294, 22226.222082227043, 22267.109315627193, 1126.7295848996346, 1136.3920302638048, 1141.4578075414279, 1143.5940241214248, 1144.753877916252, 11586.246893951866, 11831.526738930519, 12148.75702485963, 12161.209521381259, 12221.755564888652, 645767.0, 647062.0, 653617.0, 668075.0, 672447.0, 131194.34402827924, 131906.34046829704, 132321.0, 134598.0, 138225.0, 1263.8925691316158, 1284.178125999361, 1292.6509842342514, 1295.78843781065, 1302.8371453568304, 19395.127219274884, 19396.709049364552, 19409.32067377635, 19547.70678439796, 19815.108320125917, 63412.0, 65267.34732652613, 65350.673246633465, 65407.67296163679, 66897.33102669106, 81410.5929470349, 81961.0, 82406.0, 82897.58551207205, 83170.58414707887, 15889.761653575437, 16115.435959741353, 16311.510654680378, 16320.265588048329, 16337.918310408371, 23742.881285593463, 24447.51104977926, 24512.264632061066, 24781.380465487786, 24899.87550062238, 19923.900380498006, 20087.59824803525, 20189.49526261855, 20407.87756673338, 20509.89745051325, 17770.466885993443, 18114.909425452788, 18266.0, 18413.07934603291, 18502.0, 20623.690644640043, 20883.895580522, 20891.895540522808, 20986.2654807081, 20993.790062099793, 15695.450659226872, 15773.44792932242, 15776.290066946785, 15810.7628385572, 15879.761803572725, 19506.122224499646, 19841.30555430553, 19853.205871764967, 20000.59998800045, 20063.197472100954], "value": 13243.85875605463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.1638733147445, 1438.863307985741, 1446.3419144289348, 1462.3565631122299, 1498.2883130513005, 14889.404423823047, 15570.922145389271, 17867.910660446694, 18608.441746747587, 18630.44108676742, 18040.909795451003, 18162.09189540521, 18196.45410637683, 18227.54431139219, 18263.0, 3010.382871511346, 3075.538669199627, 3123.141136187544, 3127.7497800176047, 3135.0281412762115, 3013.4123845850067, 3030.4545181867256, 3033.1507177990197, 3061.0969763919697, 3061.540768884674, 3074.677158898317, 3087.6603573606885, 3133.8276394798277, 3146.8269245191505, 3159.3523327717876, 2992.251937015746, 3030.4242193983073, 3057.8929737459193, 3059.174023013796, 3062.5865508156335, 2925.824450532975, 2947.9263018424494, 2966.7329940305262, 2971.895983640584, 2972.7175918287944, 17083.40208092711, 17227.48317550463, 17305.048222347767, 17337.739933901, 17370.739438908426, 8557.229849313591, 8879.733607991771, 8918.55407229636, 8941.46351218929, 8955.462672239686, 5509.559235261169, 5650.943490565124, 5685.829425117253, 5695.316562012544, 5785.305763308388, 2177.9564408711894, 2185.0822654485155, 2185.344396681005, 2194.2429861697688, 2221.222572099752, 32056.03831885047, 32162.356752865046, 32260.677393226, 32382.190445238823, 32421.837890810395, 7303.744368947061, 7356.411487081021, 7556.2443755624, 7655.387568994467, 7685.961570192113, 21017.474563136046, 21098.156073756876, 21108.894455527625, 21156.47108822261, 21182.046807893683, 7831.2560306770765, 8623.655053797904, 8780.385373023826, 8803.515806630698, 8854.86717699235, 6761.492888033417, 7353.411727061823, 8228.259456648811, 8229.382796290301, 8244.958775206085, 6262.968685156545, 6320.367963203643, 6384.648844313608, 6411.839704007437, 6480.0, 1812.130177514774, 1831.6428296482325, 1842.7512285841508, 1863.506170864722, 1887.2451019592, 990.6532713550343, 994.1649014827435, 1002.0630710285906, 1011.1859952738116, 1026.0, 8561.874915655866, 8588.055313915589, 8630.309575233967, 8728.345374096842, 8813.25087367568, 808.1514409869731, 813.5484805932646, 815.6615004773072, 817.0685418622775, 821.4988856797349, 4988.55103040728, 5013.799448022039, 5088.745562721849, 5098.541131298127, 5128.871778205575, 25581.104661336765, 25960.0, 26673.33316667099, 26683.73316266851, 26749.598756018677, 26365.0, 26413.603795943076, 26455.735442645328, 26842.0, 26946.86526567394, 12211.328376939353, 12650.936745316214, 12723.427445764963, 12736.490540378467, 12943.935280323727, 9397.530123493934, 9419.529023548932, 9502.239820814457, 9531.285153613368, 9631.422114673142, 22066.44833879166, 22086.88956555207, 22383.32850014502, 22520.887395562917, 22937.770622293563, 23564.528709426057, 23750.762492374855, 23801.285961421185, 23955.640665390383, 23959.76040239645, 12899.097063205485, 13035.217886926815, 13236.669083272995, 13260.668483287995, 13264.469421223042, 16098.678026439171, 16156.838431615533, 16273.267702953632, 16338.836611633731, 16389.83610163883, 12211.450484728386, 12567.245965242115, 12728.809067863804, 12825.03812214069, 12830.29433381173, 12186.451609677408, 12345.444454999368, 12525.185862918881, 12600.936995314965, 12656.810147847606, 10038.799224015625, 10214.182865370902, 10229.335093218917, 10231.539580719034, 10241.0, 8138.145494722969, 8191.713290034821, 8281.29608983243, 8330.875036874331, 8375.0, 7643.617819109134, 7758.534487930742, 7790.9220907790195, 7819.296263336327, 7861.449698521277], "value": 7503.586211579782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.1707743226985, 550.4660479335043, 564.5709260961668, 570.5780203423468, 573.3607028163597, 6350.142730731356, 6371.331010243927, 6393.552451328409, 6417.486601071914, 6468.32082631324, 6241.906371404432, 6257.155284036665, 6321.8620648283295, 6323.652199129057, 6372.904406433907, 5095.388553373591, 5147.897042059157, 5174.66364686296, 5200.583953283747, 5205.27126202332, 5068.4424713281505, 5075.796968121271, 5122.6926384416865, 5215.530602245797, 5244.475552444763, 4880.658353915227, 5032.270320803481, 5044.747762611854, 5093.516115968977, 5177.741112944356, 4982.451930287683, 5003.749812509378, 5067.0, 5075.467075957008, 5090.796368145269, 4533.639908027579, 4581.931271030937, 4583.404157459542, 4606.262997920317, 4614.500287406573, 6155.784547540815, 6198.504119670461, 6204.022069406665, 6252.968735156341, 6305.675808080308, 5870.471657550841, 5939.2575928009, 5954.732037058299, 5959.679232556406, 5971.4327138921735, 6592.439642630382, 6639.668016599151, 6762.256151823295, 6786.558873673245, 6797.728090876359, 5009.298698182258, 5061.620378471629, 5083.745812709387, 5084.618653600958, 5091.719955402451, 6842.828929276759, 6845.14435695538, 6866.622335771531, 6945.305469453015, 7016.5790052597, 5205.219217117463, 5209.348831396075, 5221.164613661796, 5223.817166399233, 5250.711210883438, 5251.448597897166, 5276.0, 5302.310699609026, 5305.867353316121, 5379.811706590251, 5874.647521148745, 5928.199693041471, 5931.73307201177, 5936.910946335808, 5950.494207992283, 6738.629375384401, 6788.490863185182, 6791.117154769849, 6795.932040679629, 6833.111695479556, 1850.4911149433744, 1851.8055604161639, 1857.4891904726308, 1858.7118996555555, 1862.348178137641, 1253.7743206222967, 1281.6923938254752, 1296.1445446005591, 1299.1620404839016, 1314.6524812067516, 6448.193975753031, 6475.287718350977, 6477.093206951031, 6489.2212934447225, 6564.835879102965, 6255.937440625627, 6705.228898676714, 6745.5952642841585, 6806.18325800907, 6819.693113809891, 6308.684565771785, 6383.808485745435, 6454.709538070798, 6481.245470674944, 6517.934820651828, 3602.9099272518397, 3638.6361363863402, 3663.3955397359136, 3665.890023299305, 3666.834992425347, 7152.4278057755255, 7161.283871612901, 7216.0, 7279.41764658826, 7320.304571065741, 6852.657367131624, 6891.414229790524, 6976.5465244758925, 7077.610731409719, 7097.9645101775195, 7124.5725256484775, 7158.2841715829045, 7182.850743881058, 7215.278472152848, 7242.587695399452, 6749.291324410866, 6754.290799466182, 6772.52592318533, 6772.830679233059, 6893.75871844483, 6674.6662666865495, 6706.899396509154, 6715.697793599397, 6786.660666966731, 6822.454203663596, 7163.531476047502, 7259.382952449101, 7272.418206543358, 7277.745278915212, 7301.634918254173, 5216.37403511581, 5267.9736601316745, 5280.498352656491, 5292.470752924677, 5296.682199068068, 6569.540132190701, 6764.661766911537, 6792.558483698544, 6892.758753443605, 6979.6859141337745, 6501.122348482894, 6592.80221593353, 6611.30581288977, 6674.094540512622, 6686.0, 6579.506537009648, 6611.834704132435, 6667.766628167991, 6711.697973591103, 6755.831104222434, 6595.9105354680405, 6612.603243805387, 6640.203175618956, 6700.162479690039, 6703.3296670332575, 6622.139121914313, 6706.6646667665445, 6752.426043786333, 6768.886312296202, 6787.966060169668, 6492.480601551959, 6523.151990241238, 6544.312847150981, 6578.703958321791, 6591.8022459324375], "value": 5261.387236189704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.2758222706314, 1015.3856916565477, 1016.2682868334797, 1031.5512751952897, 1040.3393844908483, 19089.904550477244, 19389.12748926298, 19531.5117122072, 19545.902270488663, 19562.021898905034, 19748.802511974875, 20121.59756804863, 20122.899385503053, 20785.0, 20978.055987480562, 1079.8434227037076, 1099.6865893220433, 1100.2683215661616, 1103.2387652519776, 1104.0780947908465, 1070.5022164693416, 1113.6603335982522, 1116.6147679050714, 1119.4458742922266, 1119.9328040317566, 1167.0721776187952, 1182.5033485935885, 1183.9526418943233, 1183.9526418943233, 1185.6798664360617, 1157.2477889371892, 1162.2910024884814, 1163.2555164694602, 1164.1327211227647, 1164.9126315526369, 851.8296340731816, 853.5433543054498, 855.1662129423825, 860.5095095795399, 860.8966923969164, 20775.584488310302, 21280.255191068238, 21330.14679412837, 21403.67894481584, 22486.775132248633, 24242.39394015146, 24265.757342426525, 24813.25560233196, 24915.50168996628, 24934.127305544218, 17861.553461163447, 18187.727184092248, 18224.0, 18284.0, 18375.08124593765, 4207.284761590507, 4262.509811371701, 4270.210011147948, 4271.765052922088, 4274.850380236708, 163408.0, 165344.0, 165404.9999999988, 166647.1667641666, 166664.0, 18237.361692340703, 18593.675790526184, 18594.721079183822, 18599.256029758657, 18628.627427451374, 34430.13924651904, 35105.1223719409, 35301.0, 35332.64667353345, 35385.82307088448, 9565.330426870192, 9669.226461883032, 9729.4648794317, 9734.707958761248, 9773.706788796348, 4780.521947805261, 4851.587615052689, 4861.927071093936, 4866.367372241657, 4869.342638743795, 6265.216847894013, 6294.874102517924, 6308.369163083747, 6319.304876463585, 6331.65478734266, 1149.48273277024, 1151.7235863392725, 1176.129664048598, 1177.128924595793, 1178.640514643025, 769.5844244108118, 783.7883771381695, 788.4480863395646, 801.30686955784, 801.8235988082729, 13611.523596674268, 13917.443302267999, 14249.287535623178, 14527.491537796126, 14808.629784255265, 782.0927723840318, 790.5019837502451, 792.025808255837, 794.85692575337, 798.4331124901269, 6167.414095660905, 6235.376462353728, 6265.248170219603, 6288.622682639057, 6458.095866578683, 153173.0, 156336.0, 157254.21372893063, 157920.0, 162373.0, 136834.31582842022, 137005.0, 137451.0, 138011.30994345166, 144352.27823860812, 114672.0, 115490.4225478884, 115960.42019789846, 117949.0, 122031.38984305199, 11794.289827975068, 12145.514179433078, 12146.696332591757, 12207.694807629525, 12489.31308778026, 58567.4143258579, 59180.40819591921, 59410.108848368174, 59897.40102598918, 60298.698506507186, 74016.2598374031, 74100.62949685217, 74151.0, 75514.24485755072, 76378.23621763711, 17071.573210669834, 17508.037057961934, 17851.73222401691, 18141.183646735666, 18152.90923545374, 19894.10476528531, 20512.17951281932, 20611.896940515202, 20817.89591052035, 20860.68708969336, 18895.0, 18943.242270309034, 18989.14548845333, 19070.7139392912, 19226.32707855218, 18267.0, 18275.26898924028, 18300.633987319914, 18499.075046247905, 18586.907065465126, 18640.34758783436, 18673.439796806117, 18702.438926831674, 18741.156647950604, 18936.242550297833, 13642.522511712043, 13987.0, 13998.650033749238, 14031.789523157366, 14180.929095354457, 13778.793318100437, 13810.171389716648, 13921.860781392057, 13932.79100813509, 14086.366113524711], "value": 10324.995039768648, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 116.0, 104.0, 103.0, 104.0, 107.0, 105.0, 105.0, 105.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 114.0, 111.0, 111.0, 117.0, 115.0, 113.0, 113.0, 152.0], "value": 117.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 160.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 74.0, 72.0, 73.0, 81.0, 75.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 76.0, 76.0, 86.0, 77.0, 78.0, 78.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 109.0, 113.0, 111.0, 115.0, 111.0, 114.0, 114.0, 110.0], "value": 112.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 148.0, 157.0, 148.0, 147.0, 148.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 47.0, 46.0, 43.0, 47.0, 41.0, 46.0, 42.0, 42.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 41.0, 39.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 71.0, 73.0, 76.0, 69.0, 71.0, 75.0, 71.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 105.0, 103.0, 113.0, 105.0, 108.0, 104.0, 109.0, 100.0], "value": 106.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 158.0, 160.0, 155.0, 157.0, 164.0, 154.0, 153.0, 150.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 59.0, 63.0, 57.0, 68.0, 58.0, 66.0, 59.0], "value": 61.0, "unit": "score"}]}]} 08:28:05 INFO - Return code: 0 08:28:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:28:05 INFO - # TBPL SUCCESS # 08:28:05 INFO - Running post-action listener: _package_coverage_data 08:28:05 INFO - Running post-action listener: _resource_record_post_action 08:28:05 INFO - [mozharness: 2017-10-02 15:28:05.899038Z] Finished run-tests step (success) 08:28:05 INFO - Running post-run listener: _resource_record_post_run 08:28:05 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281882624; Read time: 16; Write time: 160196 08:28:05 INFO - TinderboxPrint: CPU usage
13.0% 08:28:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:28:05 INFO - TinderboxPrint: I/O write bytes / time
281,882,624 / 160,196 08:28:05 INFO - TinderboxPrint: CPU idle
8,180.7 (86.9%) 08:28:05 INFO - TinderboxPrint: CPU user
1,178.4 (12.5%) 08:28:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:28:05 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9379840; Read time: 0; Write time: 2016 08:28:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:28:06 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272502784; Read time: 16; Write time: 158180 08:28:06 INFO - Running post-run listener: _upload_blobber_files 08:28:06 INFO - Blob upload gear active. 08:28:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:06 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 08:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:28:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:08 INFO - (blobuploader) - INFO - Done attempting. 08:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:09 INFO - (blobuploader) - INFO - Done attempting. 08:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:15 INFO - (blobuploader) - INFO - Done attempting. 08:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:16 INFO - (blobuploader) - INFO - Done attempting. 08:28:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:16 INFO - Return code: 0 08:28:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/203e898cc8f877493a8fb0eeb954438d832557b6ec4e38527c17e747040bc1a3f00fb398a4c7f2876d6a7c52565146d31b096629770a2bd91097ac10cf3d9183", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e8e62e5a1594a053d340f24ae6d114bf569796e2c3b44010d4568c772a91b7dd7c95edd6fa0bef4f0be129579eb78acd5e1d638ee0851e987dc61fd2178f414", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f5eae97f07563186eb32b736d14910ccdf755997fa238db8b9d10332cdc0bf5393b6c5fbf85f2c5cc11a5522157055d2e307a8f1eff73a096a092776105e4e26", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b8aa749fe307267033cb1e7cd70e81393b9013c475d3bf9b5ec26c9946de7176b017f486c5db2c324855e303525880905932017b53ee5e9b40b64bffdea68480"} 08:28:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:16 INFO - Contents: 08:28:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/203e898cc8f877493a8fb0eeb954438d832557b6ec4e38527c17e747040bc1a3f00fb398a4c7f2876d6a7c52565146d31b096629770a2bd91097ac10cf3d9183", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e8e62e5a1594a053d340f24ae6d114bf569796e2c3b44010d4568c772a91b7dd7c95edd6fa0bef4f0be129579eb78acd5e1d638ee0851e987dc61fd2178f414", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f5eae97f07563186eb32b736d14910ccdf755997fa238db8b9d10332cdc0bf5393b6c5fbf85f2c5cc11a5522157055d2e307a8f1eff73a096a092776105e4e26", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b8aa749fe307267033cb1e7cd70e81393b9013c475d3bf9b5ec26c9946de7176b017f486c5db2c324855e303525880905932017b53ee5e9b40b64bffdea68480"} 08:28:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:16 INFO - Copying logs to upload dir... 08:28:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.081114 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 08:28:16.849022) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 08:28:16.856049) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/203e898cc8f877493a8fb0eeb954438d832557b6ec4e38527c17e747040bc1a3f00fb398a4c7f2876d6a7c52565146d31b096629770a2bd91097ac10cf3d9183", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e8e62e5a1594a053d340f24ae6d114bf569796e2c3b44010d4568c772a91b7dd7c95edd6fa0bef4f0be129579eb78acd5e1d638ee0851e987dc61fd2178f414", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f5eae97f07563186eb32b736d14910ccdf755997fa238db8b9d10332cdc0bf5393b6c5fbf85f2c5cc11a5522157055d2e307a8f1eff73a096a092776105e4e26", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b8aa749fe307267033cb1e7cd70e81393b9013c475d3bf9b5ec26c9946de7176b017f486c5db2c324855e303525880905932017b53ee5e9b40b64bffdea68480"} build_url:https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/cjAJBJ5AR2i7MSDU-xykbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/203e898cc8f877493a8fb0eeb954438d832557b6ec4e38527c17e747040bc1a3f00fb398a4c7f2876d6a7c52565146d31b096629770a2bd91097ac10cf3d9183", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e8e62e5a1594a053d340f24ae6d114bf569796e2c3b44010d4568c772a91b7dd7c95edd6fa0bef4f0be129579eb78acd5e1d638ee0851e987dc61fd2178f414", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f5eae97f07563186eb32b736d14910ccdf755997fa238db8b9d10332cdc0bf5393b6c5fbf85f2c5cc11a5522157055d2e307a8f1eff73a096a092776105e4e26", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b8aa749fe307267033cb1e7cd70e81393b9013c475d3bf9b5ec26c9946de7176b017f486c5db2c324855e303525880905932017b53ee5e9b40b64bffdea68480"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 08:28:16.887822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:28:16.888172) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506955945.212591-1570904108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:28:16.967259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 08:28:16.967574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 08:28:16.970856) ========= ========= Total master_lag: 0.50 =========