builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1508534848.87 results: success (0) revision: caed14a4e0c20b027065cb7373a9d7351a83147a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:28.874652) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:28.875134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:28.875407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:28.898319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:28.898701) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-20 14:27:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 79.2M=0s 2017-10-20 14:27:29 (79.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.207402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:29.124716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:29.125035) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:29.175901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-20 14:27:29.176255) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev caed14a4e0c20b027065cb7373a9d7351a83147a --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 caed14a4e0c20b027065cb7373a9d7351a83147a --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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-20 14:27:29,237 truncating revision to first 12 chars 2017-10-20 14:27:29,237 Setting DEBUG logging. 2017-10-20 14:27:29,237 attempt 1/10 2017-10-20 14:27:29,237 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/caed14a4e0c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-20 14:27:30,416 unpacking tar archive at: mozilla-beta-caed14a4e0c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-20 14:27:30.667714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:30.668013) ========= script_repo_revision: caed14a4e0c20b027065cb7373a9d7351a83147a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:30.668384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:30.668691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-20 14:27:30.687415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-20 14:27:30.687769) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:30 INFO - MultiFileLogger online at 20171020 14:27:30 in /builds/slave/test 14:27:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 14:27:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:30 INFO - {'append_to_log': False, 14:27:30 INFO - 'base_work_dir': '/builds/slave/test', 14:27:30 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 14:27:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:30 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 14:27:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:30 INFO - 'code_coverage': False, 14:27:30 INFO - 'config_files': ('talos/linux_config.py',), 14:27:30 INFO - 'default_actions': ('clobber', 14:27:30 INFO - 'read-buildbot-config', 14:27:30 INFO - 'download-and-extract', 14:27:30 INFO - 'populate-webroot', 14:27:30 INFO - 'create-virtualenv', 14:27:30 INFO - 'install', 14:27:30 INFO - 'setup-mitmproxy', 14:27:30 INFO - 'run-tests'), 14:27:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:30 INFO - 'disable_ccov_upload': False, 14:27:30 INFO - 'disable_stylo': False, 14:27:30 INFO - 'download_minidump_stackwalk': True, 14:27:30 INFO - 'download_symbols': 'ondemand', 14:27:30 INFO - 'enable_stylo': False, 14:27:30 INFO - 'enable_webrender': False, 14:27:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:27:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:30 INFO - 'gecko_profile': False, 14:27:30 INFO - 'gecko_profile_interval': 0, 14:27:30 INFO - 'installer_path': 'installer.exe', 14:27:30 INFO - 'log_level': 'info', 14:27:30 INFO - 'log_name': 'talos', 14:27:30 INFO - 'log_to_console': True, 14:27:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:30 INFO - 'opt_config_files': (), 14:27:30 INFO - 'pip_index': False, 14:27:30 INFO - 'suite': 'dromaeojs-e10s', 14:27:30 INFO - 'system_bits': '32', 14:27:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:30 INFO - 'title': 'talos-linux64-ix-063', 14:27:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:30 INFO - 'use_talos_json': True, 14:27:30 INFO - 'verify': 'False', 14:27:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:30 INFO - 'work_dir': 'build'} 14:27:30 INFO - [mozharness: 2017-10-20 21:27:30.887733Z] Running clobber step. 14:27:30 INFO - Running pre-action listener: _resource_record_pre_action 14:27:30 INFO - Running main action method: clobber 14:27:30 INFO - rmtree: /builds/slave/test/build 14:27:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:32 INFO - Running post-action listener: _resource_record_post_action 14:27:32 INFO - [mozharness: 2017-10-20 21:27:32.487809Z] Finished clobber step (success) 14:27:32 INFO - [mozharness: 2017-10-20 21:27:32.487906Z] Running read-buildbot-config step. 14:27:32 INFO - Running pre-action listener: _resource_record_pre_action 14:27:32 INFO - Running main action method: read_buildbot_config 14:27:32 INFO - Using buildbot properties: 14:27:32 INFO - { 14:27:32 INFO - "project": "", 14:27:32 INFO - "product": "firefox", 14:27:32 INFO - "who": "ryanvm@gmail.com", 14:27:32 INFO - "installer_path": "public/build/target.tar.bz2", 14:27:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:27:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 14:27:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 14:27:32 INFO - "stage_platform": "linux64", 14:27:32 INFO - "basedir": "/builds/slave/test", 14:27:32 INFO - "buildnumber": 145, 14:27:32 INFO - "platform": "ubuntu64_hw", 14:27:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:27:32 INFO - "slavebuilddir": "test", 14:27:32 INFO - "taskId": "VXW7apb_SMOflbUcVaFFtQ", 14:27:32 INFO - "branch": "mozilla-beta", 14:27:32 INFO - "script_repo_revision": "production", 14:27:32 INFO - "revision": "caed14a4e0c20b027065cb7373a9d7351a83147a", 14:27:32 INFO - "slavename": "talos-linux64-ix-063", 14:27:32 INFO - "repo_path": "releases/mozilla-beta" 14:27:32 INFO - } 14:27:32 INFO - Finding installer, test and symbols from parent task. 14:27:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXW7apb_SMOflbUcVaFFtQ'}, attempt #1 14:27:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXW7apb_SMOflbUcVaFFtQ'}, attempt #1 14:27:33 INFO - Task dependencies: HsarckXVTAuSLDR_pQTjLQ 14:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ'}, attempt #1 14:27:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 14:27:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.test_packages.json 14:27:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.crashreporter-symbols.zip 14:27:33 INFO - Running post-action listener: _resource_record_post_action 14:27:33 INFO - [mozharness: 2017-10-20 21:27:33.890923Z] Finished read-buildbot-config step (success) 14:27:33 INFO - [mozharness: 2017-10-20 21:27:33.891296Z] Running download-and-extract step. 14:27:33 INFO - Running pre-action listener: _resource_record_pre_action 14:27:33 INFO - Running main action method: download_and_extract 14:27:33 INFO - mkdir: /builds/slave/test/build/tests 14:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:34 INFO - trying https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.test_packages.json 14:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:27:34 INFO - Downloaded 989 bytes. 14:27:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:27:34 INFO - Using the following test package requirements: 14:27:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:27:34 INFO - u'common': [u'target.common.tests.zip'], 14:27:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:27:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:27:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:27:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:27:34 INFO - u'mozbase': [u'target.common.tests.zip'], 14:27:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:27:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:27:34 INFO - u'web-platform': [u'target.common.tests.zip', 14:27:34 INFO - u'target.web-platform.tests.tar.gz'], 14:27:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:27:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:27:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.common.tests.zip 14:27:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:27:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.common.tests.zip into memory 14:27:37 INFO - Content-Length response header: 55170154 14:27:37 INFO - Bytes received: 55170154 14:27:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.talos.tests.zip 14:27:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:27:48 INFO - Fetch https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.talos.tests.zip into memory 14:27:49 INFO - Content-Length response header: 14509096 14:27:49 INFO - Bytes received: 14509096 14:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:49 INFO - trying https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 14:27:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:27:51 INFO - Downloaded 53578849 bytes. 14:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 14:27:51 INFO - mkdir: /builds/slave/test/properties 14:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:51 INFO - Contents: 14:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 14:27:51 INFO - Running post-action listener: _resource_record_post_action 14:27:51 INFO - Running post-action listener: find_tests_for_verification 14:27:51 INFO - Running post-action listener: set_extra_try_arguments 14:27:51 INFO - [mozharness: 2017-10-20 21:27:51.713125Z] Finished download-and-extract step (success) 14:27:51 INFO - [mozharness: 2017-10-20 21:27:51.713352Z] Running populate-webroot step. 14:27:51 INFO - Running pre-action listener: _resource_record_pre_action 14:27:51 INFO - Running main action method: populate_webroot 14:27:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['tresize', 14:27:51 INFO - 'tcanvasmark']}, 14:27:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['dromaeo_css', 14:27:51 INFO - 'kraken']}, 14:27:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'tests': ['damp', 'tps']}, 14:27:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['damp', 'tps']}, 14:27:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['dromaeo_dom']}, 14:27:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:27:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['basic_compositor_video', 14:27:51 INFO - 'glvideo']}, 14:27:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:27:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['ts_paint_webext', 14:27:51 INFO - 'tp5o_webext']}, 14:27:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:51 INFO - 'ts_paint', 14:27:51 INFO - 'tpaint', 14:27:51 INFO - 'sessionrestore', 14:27:51 INFO - 'sessionrestore_many_windows', 14:27:51 INFO - 'sessionrestore_no_auto_restore', 14:27:51 INFO - 'tabpaint']}, 14:27:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['a11yr', 14:27:51 INFO - 'ts_paint', 14:27:51 INFO - 'tpaint', 14:27:51 INFO - 'sessionrestore', 14:27:51 INFO - 'sessionrestore_many_windows', 14:27:51 INFO - 'sessionrestore_no_auto_restore', 14:27:51 INFO - 'tabpaint']}, 14:27:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:27:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:27:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['perf_reftest_singletons']}, 14:27:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['bloom_basic']}, 14:27:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:51 INFO - 'tsvgr_opacity', 14:27:51 INFO - 'tart', 14:27:51 INFO - 'tscrollx', 14:27:51 INFO - 'tsvg_static']}, 14:27:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['tsvgx', 14:27:51 INFO - 'tsvgr_opacity', 14:27:51 INFO - 'tart', 14:27:51 INFO - 'tscrollx', 14:27:51 INFO - 'tsvg_static']}, 14:27:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:27:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo'], 14:27:51 INFO - 'tests': ['tp5o']}, 14:27:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:51 INFO - 'talos_options': ['--mitmproxy', 14:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:51 INFO - '--firstNonBlankPaint'], 14:27:51 INFO - 'tests': ['tp6_google', 14:27:51 INFO - 'tp6_youtube', 14:27:51 INFO - 'tp6_amazon', 14:27:51 INFO - 'tp6_facebook']}, 14:27:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo', 14:27:51 INFO - '--mitmproxy', 14:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:51 INFO - '--firstNonBlankPaint'], 14:27:51 INFO - 'tests': ['tp6_google', 14:27:51 INFO - 'tp6_youtube', 14:27:51 INFO - 'tp6_amazon', 14:27:51 INFO - 'tp6_facebook']}, 14:27:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:51 INFO - 'talos_options': ['--stylo-threads=1', 14:27:51 INFO - '--mitmproxy', 14:27:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:51 INFO - '--firstNonBlankPaint'], 14:27:51 INFO - 'tests': ['tp6_google', 14:27:51 INFO - 'tp6_youtube', 14:27:51 INFO - 'tp6_amazon', 14:27:51 INFO - 'tp6_facebook']}, 14:27:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--xperf_path', 14:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:51 INFO - 'tests': ['tp5n']}, 14:27:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:27:51 INFO - 'talos_options': ['--disable-stylo', 14:27:51 INFO - '--xperf_path', 14:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:51 INFO - 'tests': ['tp5n']}}} 14:27:51 INFO - Running post-action listener: _resource_record_post_action 14:27:51 INFO - [mozharness: 2017-10-20 21:27:51.729534Z] Finished populate-webroot step (success) 14:27:51 INFO - [mozharness: 2017-10-20 21:27:51.729623Z] Running create-virtualenv step. 14:27:51 INFO - Running pre-action listener: _resource_record_pre_action 14:27:51 INFO - Running main action method: create_virtualenv 14:27:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:27:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:27:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:27:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:52 INFO - Installing pip...............done. 14:27:52 INFO - Return code: 0 14:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:27:52 INFO - Reading from file tmpfile_stdout 14:27:52 INFO - Output received: 14:27:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:27:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:27:52 INFO - Using env: {'DISPLAY': ':0', 14:27:52 INFO - 'HOME': '/home/cltbld', 14:27:52 INFO - 'LANG': 'en_US.UTF-8', 14:27:52 INFO - 'LANGUAGE': 'en_US:en', 14:27:52 INFO - 'LOGNAME': 'cltbld', 14:27:52 INFO - 'MAIL': '/var/mail/cltbld', 14:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:52 INFO - 'MOZ_NO_REMOTE': '1', 14:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:52 INFO - 'NO_EM_RESTART': '1', 14:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:52 INFO - 'PWD': '/builds/slave/test', 14:27:52 INFO - 'SHELL': '/bin/bash', 14:27:52 INFO - 'SHLVL': '1', 14:27:52 INFO - 'TERM': 'linux', 14:27:52 INFO - 'TMOUT': '86400', 14:27:52 INFO - 'USER': 'cltbld', 14:27:52 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:52 INFO - '_': '/tools/buildbot/bin/python'} 14:27:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:27:54 INFO - Downloading/unpacking pip>=1.5 14:27:54 INFO - Running setup.py egg_info for package pip 14:27:54 INFO - warning: no files found matching 'pip/cacert.pem' 14:27:54 INFO - warning: no files found matching '*.html' under directory 'docs' 14:27:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:27:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:27:54 INFO - Installing collected packages: pip 14:27:54 INFO - Found existing installation: pip 1.1 14:27:54 INFO - Uninstalling pip: 14:27:54 INFO - Successfully uninstalled pip 14:27:54 INFO - Running setup.py install for pip 14:27:54 INFO - warning: no files found matching 'pip/cacert.pem' 14:27:54 INFO - warning: no files found matching '*.html' under directory 'docs' 14:27:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:27:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:27:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:27:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:27:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:27:54 INFO - Successfully installed pip 14:27:54 INFO - Cleaning up... 14:27:54 INFO - Return code: 0 14:27:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:27:54 INFO - Using env: {'DISPLAY': ':0', 14:27:54 INFO - 'HOME': '/home/cltbld', 14:27:54 INFO - 'LANG': 'en_US.UTF-8', 14:27:54 INFO - 'LANGUAGE': 'en_US:en', 14:27:54 INFO - 'LOGNAME': 'cltbld', 14:27:54 INFO - 'MAIL': '/var/mail/cltbld', 14:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:54 INFO - 'MOZ_NO_REMOTE': '1', 14:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:54 INFO - 'NO_EM_RESTART': '1', 14:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:54 INFO - 'PWD': '/builds/slave/test', 14:27:54 INFO - 'SHELL': '/bin/bash', 14:27:54 INFO - 'SHLVL': '1', 14:27:54 INFO - 'TERM': 'linux', 14:27:54 INFO - 'TMOUT': '86400', 14:27:54 INFO - 'USER': 'cltbld', 14:27:54 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:54 INFO - '_': '/tools/buildbot/bin/python'} 14:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:54 INFO - Downloading/unpacking psutil>=3.1.1 14:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:55 INFO - Installing collected packages: psutil 14:27:55 INFO - Running setup.py install for psutil 14:27:55 INFO - building 'psutil._psutil_linux' extension 14:27:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:27:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:27:56 INFO - building 'psutil._psutil_posix' extension 14:27:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:27:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:56 INFO - Successfully installed psutil 14:27:56 INFO - Cleaning up... 14:27:57 INFO - Return code: 0 14:27:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:27:57 INFO - Using env: {'DISPLAY': ':0', 14:27:57 INFO - 'HOME': '/home/cltbld', 14:27:57 INFO - 'LANG': 'en_US.UTF-8', 14:27:57 INFO - 'LANGUAGE': 'en_US:en', 14:27:57 INFO - 'LOGNAME': 'cltbld', 14:27:57 INFO - 'MAIL': '/var/mail/cltbld', 14:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:57 INFO - 'MOZ_NO_REMOTE': '1', 14:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:57 INFO - 'NO_EM_RESTART': '1', 14:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:57 INFO - 'PWD': '/builds/slave/test', 14:27:57 INFO - 'SHELL': '/bin/bash', 14:27:57 INFO - 'SHLVL': '1', 14:27:57 INFO - 'TERM': 'linux', 14:27:57 INFO - 'TMOUT': '86400', 14:27:57 INFO - 'USER': 'cltbld', 14:27:57 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:57 INFO - '_': '/tools/buildbot/bin/python'} 14:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:58 INFO - Installing collected packages: mozsystemmonitor 14:27:58 INFO - Running setup.py install for mozsystemmonitor 14:27:58 INFO - Successfully installed mozsystemmonitor 14:27:58 INFO - Cleaning up... 14:27:59 INFO - Return code: 0 14:27:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:27:59 INFO - Using env: {'DISPLAY': ':0', 14:27:59 INFO - 'HOME': '/home/cltbld', 14:27:59 INFO - 'LANG': 'en_US.UTF-8', 14:27:59 INFO - 'LANGUAGE': 'en_US:en', 14:27:59 INFO - 'LOGNAME': 'cltbld', 14:27:59 INFO - 'MAIL': '/var/mail/cltbld', 14:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:59 INFO - 'MOZ_NO_REMOTE': '1', 14:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:59 INFO - 'NO_EM_RESTART': '1', 14:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:59 INFO - 'PWD': '/builds/slave/test', 14:27:59 INFO - 'SHELL': '/bin/bash', 14:27:59 INFO - 'SHLVL': '1', 14:27:59 INFO - 'TERM': 'linux', 14:27:59 INFO - 'TMOUT': '86400', 14:27:59 INFO - 'USER': 'cltbld', 14:27:59 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:59 INFO - '_': '/tools/buildbot/bin/python'} 14:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:59 INFO - Downloading/unpacking jsonschema==2.5.1 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:01 INFO - warning: no files found matching '*.txt' 14:28:01 INFO - no previously-included directories found matching 'build' 14:28:01 INFO - no previously-included directories found matching 'dist' 14:28:01 INFO - no previously-included directories found matching '.git*' 14:28:01 INFO - Installing collected packages: jsonschema, functools32 14:28:01 INFO - Running setup.py install for functools32 14:28:01 INFO - warning: no files found matching '*.txt' 14:28:01 INFO - no previously-included directories found matching 'build' 14:28:01 INFO - no previously-included directories found matching 'dist' 14:28:01 INFO - no previously-included directories found matching '.git*' 14:28:01 INFO - Successfully installed jsonschema functools32 14:28:01 INFO - Cleaning up... 14:28:01 INFO - Return code: 0 14:28:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:01 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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:28:01 INFO - Using env: {'DISPLAY': ':0', 14:28:01 INFO - 'HOME': '/home/cltbld', 14:28:01 INFO - 'LANG': 'en_US.UTF-8', 14:28:01 INFO - 'LANGUAGE': 'en_US:en', 14:28:01 INFO - 'LOGNAME': 'cltbld', 14:28:01 INFO - 'MAIL': '/var/mail/cltbld', 14:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:01 INFO - 'MOZ_NO_REMOTE': '1', 14:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:01 INFO - 'NO_EM_RESTART': '1', 14:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:01 INFO - 'PWD': '/builds/slave/test', 14:28:01 INFO - 'SHELL': '/bin/bash', 14:28:01 INFO - 'SHLVL': '1', 14:28:01 INFO - 'TERM': 'linux', 14:28:01 INFO - 'TMOUT': '86400', 14:28:01 INFO - 'USER': 'cltbld', 14:28:01 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:01 INFO - '_': '/tools/buildbot/bin/python'} 14:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:28:01 INFO - Cleaning up... 14:28:01 INFO - Return code: 0 14:28:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:01 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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:28:01 INFO - Using env: {'DISPLAY': ':0', 14:28:01 INFO - 'HOME': '/home/cltbld', 14:28:01 INFO - 'LANG': 'en_US.UTF-8', 14:28:01 INFO - 'LANGUAGE': 'en_US:en', 14:28:01 INFO - 'LOGNAME': 'cltbld', 14:28:01 INFO - 'MAIL': '/var/mail/cltbld', 14:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:01 INFO - 'MOZ_NO_REMOTE': '1', 14:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:01 INFO - 'NO_EM_RESTART': '1', 14:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:01 INFO - 'PWD': '/builds/slave/test', 14:28:01 INFO - 'SHELL': '/bin/bash', 14:28:01 INFO - 'SHLVL': '1', 14:28:01 INFO - 'TERM': 'linux', 14:28:01 INFO - 'TMOUT': '86400', 14:28:01 INFO - 'USER': 'cltbld', 14:28:01 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:01 INFO - '_': '/tools/buildbot/bin/python'} 14:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:01 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:02 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:03 INFO - Downloading docopt-0.6.1.tar.gz 14:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:03 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:03 INFO - Running setup.py install for blobuploader 14:28:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:03 INFO - Running setup.py install for requests 14:28:04 INFO - Running setup.py install for docopt 14:28:04 INFO - Successfully installed blobuploader requests docopt 14:28:04 INFO - Cleaning up... 14:28:04 INFO - Return code: 0 14:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:04 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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:04 INFO - Using env: {'DISPLAY': ':0', 14:28:04 INFO - 'HOME': '/home/cltbld', 14:28:04 INFO - 'LANG': 'en_US.UTF-8', 14:28:04 INFO - 'LANGUAGE': 'en_US:en', 14:28:04 INFO - 'LOGNAME': 'cltbld', 14:28:04 INFO - 'MAIL': '/var/mail/cltbld', 14:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:04 INFO - 'MOZ_NO_REMOTE': '1', 14:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:04 INFO - 'NO_EM_RESTART': '1', 14:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:04 INFO - 'PWD': '/builds/slave/test', 14:28:04 INFO - 'SHELL': '/bin/bash', 14:28:04 INFO - 'SHLVL': '1', 14:28:04 INFO - 'TERM': 'linux', 14:28:04 INFO - 'TMOUT': '86400', 14:28:04 INFO - 'USER': 'cltbld', 14:28:04 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:04 INFO - '_': '/tools/buildbot/bin/python'} 14:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:04 INFO - Running setup.py (path:/tmp/pip-tkDv_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:04 INFO - Running setup.py (path:/tmp/pip-mfWvFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:04 INFO - Running setup.py (path:/tmp/pip-UTWPyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:04 INFO - Running setup.py (path:/tmp/pip-pgAU76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:04 INFO - Running setup.py (path:/tmp/pip-2_aY4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:04 INFO - Running setup.py (path:/tmp/pip-42XzOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:04 INFO - Running setup.py (path:/tmp/pip-FP9EFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:05 INFO - Running setup.py (path:/tmp/pip-TMJA9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:05 INFO - Running setup.py (path:/tmp/pip-2qbXgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:05 INFO - Running setup.py (path:/tmp/pip-n_1oGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:05 INFO - Running setup.py (path:/tmp/pip-WMPRXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:05 INFO - Running setup.py (path:/tmp/pip-jLg6PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:05 INFO - Running setup.py (path:/tmp/pip-VvpNym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:05 INFO - Running setup.py (path:/tmp/pip-LaWeqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:05 INFO - Running setup.py (path:/tmp/pip-TiV03j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:05 INFO - Running setup.py (path:/tmp/pip-cKZX0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:05 INFO - Running setup.py (path:/tmp/pip-xmXq8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:05 INFO - Running setup.py install for manifestparser 14:28:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:05 INFO - Running setup.py install for mozcrash 14:28:05 INFO - Running setup.py install for mozdebug 14:28:06 INFO - Running setup.py install for mozdevice 14:28:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for mozfile 14:28:06 INFO - Running setup.py install for mozhttpd 14:28:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for mozinfo 14:28:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for mozInstall 14:28:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for mozleak 14:28:06 INFO - Running setup.py install for mozlog 14:28:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for moznetwork 14:28:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:06 INFO - Running setup.py install for mozprocess 14:28:06 INFO - Running setup.py install for mozprofile 14:28:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:07 INFO - Running setup.py install for mozrunner 14:28:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:07 INFO - Running setup.py install for mozscreenshot 14:28:07 INFO - Running setup.py install for moztest 14:28:07 INFO - Running setup.py install for mozversion 14:28:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:07 INFO - Cleaning up... 14:28:07 INFO - Return code: 0 14:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28: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')]} 14:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:07 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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:07 INFO - Using env: {'DISPLAY': ':0', 14:28:07 INFO - 'HOME': '/home/cltbld', 14:28:07 INFO - 'LANG': 'en_US.UTF-8', 14:28:07 INFO - 'LANGUAGE': 'en_US:en', 14:28:07 INFO - 'LOGNAME': 'cltbld', 14:28:07 INFO - 'MAIL': '/var/mail/cltbld', 14:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:07 INFO - 'MOZ_NO_REMOTE': '1', 14:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:07 INFO - 'NO_EM_RESTART': '1', 14:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:07 INFO - 'PWD': '/builds/slave/test', 14:28:07 INFO - 'SHELL': '/bin/bash', 14:28:07 INFO - 'SHLVL': '1', 14:28:07 INFO - 'TERM': 'linux', 14:28:07 INFO - 'TMOUT': '86400', 14:28:07 INFO - 'USER': 'cltbld', 14:28:07 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:07 INFO - '_': '/tools/buildbot/bin/python'} 14:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:07 INFO - Running setup.py (path:/tmp/pip-ZtbTMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:07 INFO - Running setup.py (path:/tmp/pip-0CmA3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:07 INFO - Running setup.py (path:/tmp/pip-4vlwvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:07 INFO - Running setup.py (path:/tmp/pip-N16KwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:08 INFO - Running setup.py (path:/tmp/pip-myvhGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:08 INFO - Running setup.py (path:/tmp/pip-IzCUIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:08 INFO - Running setup.py (path:/tmp/pip-F8djIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:08 INFO - Running setup.py (path:/tmp/pip-vzIltw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:08 INFO - Running setup.py (path:/tmp/pip-Tn0GHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:08 INFO - Running setup.py (path:/tmp/pip-pbPjvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:08 INFO - Running setup.py (path:/tmp/pip-EzpUiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:08 INFO - Running setup.py (path:/tmp/pip-4m_cDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:08 INFO - Running setup.py (path:/tmp/pip-DUeleh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:08 INFO - Running setup.py (path:/tmp/pip-L5c4E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:08 INFO - Running setup.py (path:/tmp/pip-SZmXvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:08 INFO - Running setup.py (path:/tmp/pip-NK_Eie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:08 INFO - Running setup.py (path:/tmp/pip-IrWs9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:10 INFO - Downloading blessings-1.6.tar.gz 14:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:10 INFO - Installing collected packages: blessings 14:28:10 INFO - Running setup.py install for blessings 14:28:10 INFO - Successfully installed blessings 14:28:10 INFO - Cleaning up... 14:28:10 INFO - Return code: 0 14:28:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:10 INFO - Reading from file tmpfile_stdout 14:28:10 INFO - Current package versions: 14:28:10 INFO - argparse == 1.2.1 14:28:10 INFO - blessings == 1.6 14:28:10 INFO - blobuploader == 1.2.4 14:28:10 INFO - docopt == 0.6.1 14:28:10 INFO - functools32 == 3.2.3-2 14:28:10 INFO - jsonschema == 2.5.1 14:28:10 INFO - manifestparser == 1.1 14:28:10 INFO - mozInstall == 1.13 14:28:10 INFO - mozcrash == 1.0 14:28:10 INFO - mozdebug == 0.1 14:28:10 INFO - mozdevice == 0.51 14:28:10 INFO - mozfile == 1.2 14:28:10 INFO - mozhttpd == 0.7 14:28:10 INFO - mozinfo == 0.10 14:28:10 INFO - mozleak == 0.1 14:28:10 INFO - mozlog == 3.5 14:28:10 INFO - moznetwork == 0.27 14:28:10 INFO - mozprocess == 0.25 14:28:10 INFO - mozprofile == 0.28 14:28:10 INFO - mozrunner == 6.13 14:28:10 INFO - mozscreenshot == 0.1 14:28:10 INFO - mozsystemmonitor == 0.3 14:28:10 INFO - moztest == 0.8 14:28:10 INFO - mozversion == 1.4 14:28:10 INFO - psutil == 3.1.1 14:28:10 INFO - requests == 1.2.3 14:28:10 INFO - wsgiref == 0.1.2 14:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:10 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 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:10 INFO - Using env: {'DISPLAY': ':0', 14:28:10 INFO - 'HOME': '/home/cltbld', 14:28:10 INFO - 'LANG': 'en_US.UTF-8', 14:28:10 INFO - 'LANGUAGE': 'en_US:en', 14:28:10 INFO - 'LOGNAME': 'cltbld', 14:28:10 INFO - 'MAIL': '/var/mail/cltbld', 14:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:10 INFO - 'MOZ_NO_REMOTE': '1', 14:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:10 INFO - 'NO_EM_RESTART': '1', 14:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:10 INFO - 'PWD': '/builds/slave/test', 14:28:10 INFO - 'SHELL': '/bin/bash', 14:28:10 INFO - 'SHLVL': '1', 14:28:10 INFO - 'TERM': 'linux', 14:28:10 INFO - 'TMOUT': '86400', 14:28:10 INFO - 'USER': 'cltbld', 14:28:10 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:10 INFO - '_': '/tools/buildbot/bin/python'} 14:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:28:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:12 INFO - Installing collected packages: simplejson 14:28:12 INFO - Running setup.py install for simplejson 14:28:12 INFO - building 'simplejson._speedups' extension 14:28:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 14:28:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 14:28:13 INFO - Successfully installed simplejson 14:28:13 INFO - Cleaning up... 14:28:13 INFO - Return code: 0 14:28:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28: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')]} 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28: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', 'jsonschema'] in /builds/slave/test/build 14:28: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 jsonschema 14:28:13 INFO - Using env: {'DISPLAY': ':0', 14:28:13 INFO - 'HOME': '/home/cltbld', 14:28:13 INFO - 'LANG': 'en_US.UTF-8', 14:28:13 INFO - 'LANGUAGE': 'en_US:en', 14:28:13 INFO - 'LOGNAME': 'cltbld', 14:28:13 INFO - 'MAIL': '/var/mail/cltbld', 14:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:13 INFO - 'MOZ_NO_REMOTE': '1', 14:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:13 INFO - 'NO_EM_RESTART': '1', 14:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:13 INFO - 'PWD': '/builds/slave/test', 14:28:13 INFO - 'SHELL': '/bin/bash', 14:28:13 INFO - 'SHLVL': '1', 14:28:13 INFO - 'TERM': 'linux', 14:28:13 INFO - 'TMOUT': '86400', 14:28:13 INFO - 'USER': 'cltbld', 14:28:13 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:13 INFO - '_': '/tools/buildbot/bin/python'} 14:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:13 INFO - Cleaning up... 14:28:13 INFO - Return code: 0 14:28:13 INFO - Running post-action listener: _resource_record_post_action 14:28:13 INFO - Running post-action listener: _start_resource_monitoring 14:28:13 INFO - Starting resource monitoring. 14:28:13 INFO - [mozharness: 2017-10-20 21:28:13.352284Z] Finished create-virtualenv step (success) 14:28:13 INFO - [mozharness: 2017-10-20 21:28:13.352754Z] Running install step. 14:28:13 INFO - Running pre-action listener: _resource_record_pre_action 14:28:13 INFO - Running main action method: install 14:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:13 INFO - Reading from file tmpfile_stdout 14:28:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:13 INFO - Reading from file tmpfile_stdout 14:28:13 INFO - Output received: 14:28:13 INFO - Usage: mozinstall [options] installer 14:28:13 INFO - Options: 14:28:13 INFO - -h, --help show this help message and exit 14:28:13 INFO - -d DEST, --destination=DEST 14:28:13 INFO - Directory to install application into. [default: 14:28:13 INFO - "/builds/slave/test"] 14:28:13 INFO - --app=APP Application being installed. [default: firefox] 14:28:13 INFO - mkdir: /builds/slave/test/build/application 14:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:28:28 INFO - Reading from file tmpfile_stdout 14:28:28 INFO - Output received: 14:28:28 INFO - /builds/slave/test/build/application/firefox/firefox 14:28:28 INFO - Running post-action listener: _resource_record_post_action 14:28:28 INFO - [mozharness: 2017-10-20 21:28:28.354217Z] Finished install step (success) 14:28:28 INFO - [mozharness: 2017-10-20 21:28:28.354465Z] Running setup-mitmproxy step. 14:28:28 INFO - Running pre-action listener: _resource_record_pre_action 14:28:28 INFO - Running main action method: setup_mitmproxy 14:28:28 INFO - Skipping: mitmproxy is not required 14:28:28 INFO - Running post-action listener: _resource_record_post_action 14:28:28 INFO - [mozharness: 2017-10-20 21:28:28.355666Z] Finished setup-mitmproxy step (success) 14:28:28 INFO - [mozharness: 2017-10-20 21:28:28.355887Z] Running run-tests step. 14:28:28 INFO - Running pre-action listener: _resource_record_pre_action 14:28:28 INFO - Running pre-action listener: _set_gcov_prefix 14:28:28 INFO - Running main action method: run_tests 14:28:28 WARNING - Try message not found. 14:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:28 INFO - Python 2.7.3 14:28:28 INFO - Return code: 0 14:28:28 INFO - grabbing minidump binary from tooltool 14:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:28 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 0x2933090>, '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 0x2933d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:28:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:28:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:28:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:28 INFO - Return code: 0 14:28:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:28:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:28 INFO - ENV: RUST_BACKTRACE is now full 14:28:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:28:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:28 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/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:28:28 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/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:28:28 INFO - Using env: {'DISPLAY': ':0', 14:28:28 INFO - 'HOME': '/home/cltbld', 14:28:28 INFO - 'LANG': 'en_US.UTF-8', 14:28:28 INFO - 'LANGUAGE': 'en_US:en', 14:28:28 INFO - 'LOGNAME': 'cltbld', 14:28:28 INFO - 'MAIL': '/var/mail/cltbld', 14:28:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:28 INFO - 'MOZ_NO_REMOTE': '1', 14:28:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:28 INFO - 'NO_EM_RESTART': '1', 14:28:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:28 INFO - 'PWD': '/builds/slave/test', 14:28:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:28 INFO - 'RUST_BACKTRACE': 'full', 14:28:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:28:28 INFO - 'SHELL': '/bin/bash', 14:28:28 INFO - 'SHLVL': '1', 14:28:28 INFO - 'TERM': 'linux', 14:28:28 INFO - 'TMOUT': '86400', 14:28:28 INFO - 'USER': 'cltbld', 14:28:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:28 INFO - '_': '/tools/buildbot/bin/python'} 14:28:28 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/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:28:28 INFO - mozversion application_buildid: 20171020201257 14:28:28 INFO - mozversion application_changeset: caed14a4e0c20b027065cb7373a9d7351a83147a 14:28:28 INFO - mozversion application_display_name: Firefox 14:28:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:28 INFO - mozversion application_name: Firefox 14:28:28 INFO - mozversion application_remotingname: firefox 14:28:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:28 INFO - mozversion application_vendor: Mozilla 14:28:28 INFO - mozversion application_version: 57.0 14:28:28 INFO - mozversion platform_buildid: 20171020201257 14:28:28 INFO - mozversion platform_changeset: caed14a4e0c20b027065cb7373a9d7351a83147a 14:28:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:28 INFO - mozversion platform_version: 57.0 14:28:28 INFO - using testdate: 1508534908 14:28:28 INFO - actual date: 1508534908 14:28:28 INFO - starting webserver on 'localhost:58063' 14:28:28 INFO - SUITE-START | Running 2 tests 14:28:28 INFO - TEST-START | dromaeo_css 14:28:28 INFO - Initialising browser for dromaeo_css test... 14:28:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58063/getInfo.html -profile /tmp/tmpR2Lbly/profile 14:28:28 INFO - TEST-INFO | started process 7251 (/builds/slave/test/build/application/firefox/firefox http://localhost:58063/getInfo.html) 14:28:33 INFO - TEST-INFO | 7251: exit 0 14:28:34 INFO - Browser initialized. 14:28:34 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:34 INFO - Using env: {'DISPLAY': ':0', 14:28:34 INFO - 'HOME': '/home/cltbld', 14:28:34 INFO - 'JSGC_DISABLE_POISONING': '1', 14:28:34 INFO - 'LANG': 'en_US.UTF-8', 14:28:34 INFO - 'LANGUAGE': 'en_US:en', 14:28:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:28:34 INFO - 'LOGNAME': 'cltbld', 14:28:34 INFO - 'MAIL': '/var/mail/cltbld', 14:28:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:34 INFO - 'MOZ_CRASHREPORTER': '1', 14:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:28:34 INFO - 'MOZ_NO_REMOTE': '1', 14:28:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:34 INFO - 'NO_EM_RESTART': '1', 14:28:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:34 INFO - 'PWD': '/builds/slave/test', 14:28:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:34 INFO - 'RUST_BACKTRACE': 'full', 14:28:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:28:34 INFO - 'SHELL': '/bin/bash', 14:28:34 INFO - 'SHLVL': '1', 14:28:34 INFO - 'TERM': 'linux', 14:28:34 INFO - 'TMOUT': '86400', 14:28:34 INFO - 'USER': 'cltbld', 14:28:34 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:34 INFO - '_': '/tools/buildbot/bin/python'} 14:28:34 INFO - TEST-INFO | started process 7488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR2Lbly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:34 INFO - PID 7488 | 14:28:34 INFO - PID 7488 | (/builds/slave/test/build/application/firefox/firefox:7536): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:28:34 INFO - PID 7488 | 14:28:45 INFO - PID 7488 | RSS: Main: 141725696 14:28:45 INFO - PID 7488 | 14:31:42 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58063/tests/dromaeo/cssquery-ext.html) 14:31:43 INFO - PID 7488 | RSS: Main: 145870848 14:31:43 INFO - PID 7488 | 14:34:44 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-ext.html (next: http://localhost:58063/tests/dromaeo/cssquery-jquery.html) 14:34:45 INFO - PID 7488 | RSS: Main: 144179200 14:34:45 INFO - PID 7488 | 14:37:46 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58063/tests/dromaeo/cssquery-mootools.html) 14:37:47 INFO - PID 7488 | RSS: Main: 145305600 14:37:47 INFO - PID 7488 | 14:40:49 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58063/tests/dromaeo/cssquery-prototype.html) 14:40:49 INFO - PID 7488 | RSS: Main: 145305600 14:40:49 INFO - PID 7488 | 14:43:52 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58063/tests/dromaeo/cssquery-yui.html) 14:43:53 INFO - PID 7488 | RSS: Main: 145920000 14:43:53 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | Cycle 1(1): loaded http://localhost:58063/tests/dromaeo/cssquery-yui.html (next: http://localhost:58063/tests/dromaeo/cssquery-dojo.html) 14:46:54 INFO - PID 7488 | RSS: Main: 149094400 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | __start_tp_report 14:46:54 INFO - PID 7488 | _x_x_mozilla_page_load 14:46:54 INFO - PID 7488 | _x_x_mozilla_page_load_details 14:46:54 INFO - PID 7488 | |i|pagename|runs| 14:46:54 INFO - PID 7488 | |0;dojo.html;3978.7811670358137;3984.3824207247876;4023.939640905387;4032.2540330038946;4036.979815100924;6358.109864618957;6361.2048493938255;6431.774887878925;6457.580257283279;6472.805815825527;6384.042393640944;6414.807555773335;6475.514336424775;6499.80500584982;6502.80491585252;5725.456081672255;5778.508826749731;5826.359100498942;5859;5864.618799778023;5689.345725241588;5776.104703770901;5784.797532086378;5790.276215473066;5928.2293301870695;5822.82531524055;5909;5927.762889484416;5958.79144229952;5963.135345374918;5822.796202132948;5920.348761636216;5978.521718262528;5988.940110598904;6009.308929473101;5739.282589676291;5803.448672376117;5875.676837773921;5894.204282421904;6001.1898393717165;6402.13571167891;6432.967835160841;6436.517261205381;6484.93515064848;6495.837604059889;7030.753923612649;7075.115610548682;7116.537425067354;7132;7162;7029;7068.646567671647;7086.3976561992295;7147.892781608228;7147.964260178718;6428.4214420702365;6515;6540;6600.834979125512;6656.700448479878;7226.710931562784;7288.70845166198;7301.744438944612;7306.378957788541;7326.450516211199;6908.1364829396325;6937.653117344113;6967.860642787217;6979.581225126407;7007.334303241184;6926.960955856662;7053.858922821515;7079.327463891025;7099.503034787618;7107.040549525851;7004.92995070053;7097.89353159703;7098.36114749675;7108.0048793169;7113.146422429341;6995.650217489207;7000.474964377692;7032.472564557678;7083.397911177608;7105.396041336544;5124.92312615311;5133.050385678586;5152.4847515248175;5189.870253243699;5207.453217412193;4726.598239149642;4732.95267047332;4772.689775164603;4810;4832.637552183601;6663.633500157441;6687.899681504781;6731.091302674175;6735.057092007123;6740.898886516707;6919.481038922101;7014.473914456335;7019.982102595095;7113.502054856214;7113.92886071143;6466.579672321284;6582.736690532421;6588.769393071219;6661.833454163685;6719.395254427125;5809.535237181015;5812.447817457335;5818.127280907897;5822.417758224144;5827.737751801179;7163.06880105583;7179.92820071803;7211.278872112747;7267.164276108315;7286.599237041907;6946.756863509753;6947.270536593787;6959.164900212007;6966.094407726963;7022.473314501535;7283.963580182065;7288.854222915618;7296.19741828409;7309.415246780139;7316.561006339637;6920.273371295942;6924.826879327856;6933.583984960716;6935.994280829151;6950.235474097744;6941.271166527644;6966.895496567657;6978.965105174441;6986.755463558751;7004.124484439445;6667.233268174222;6673.432758215606;6681.899771503528;6763.154605674291;6778.966105169443;6678.532502724957;6721.361470660279;6761.290064543152;6826.214985276757;6827.453803695792;6750.763723269662;6769.28922463154;6796.76211332601;6804.727810887707;6833.077534532973;6873.450123990169;6890.31096890307;6927.238003819677;6931.341522555349;6949;6670.899936501053;6673.699683514156;6758;6779.288174741779;6779.779639664907 14:46:54 INFO - PID 7488 | |1;ext.html;1004.6935684616194;1024.0732137415637;1026.6509386808484;1026.973026973027;1030.634124885666;46897.76551117244;47523.52476475234;47588.286175707304;47682.28476572846;47754;44755.55244447554;44993.325100123526;45016.549834501646;45087.774561127146;45119.32321015187;8068.798280042987;8298.958505207465;8398.286145677625;8456.577171141449;8473.237408633222;8810.515421651806;8923.910760892406;8927.910720892773;8928.330375221853;8930.330225233101;8874.778130546756;8920.464772113693;8927.241184499326;8946;8965.282777377794;8854.690085846996;8897.377183597151;8915.375923685344;8925.28597712188;8939.642414303453;8515.318774498088;8523.74428767138;8569.914300856974;8573.399862009663;8577.228049475578;43348.566514335085;43440.78279608613;43480;43763.12473750539;43867.341989870176;3837.827297771607;3901.648851603369;3903.941440878389;3904.590018048121;3906.628870257321;34005.6599434005;34090.48864267038;34704.13239669003;34912.30175396503;35113;5555.861103472405;5595.300587426572;5626.690532020737;5628.296462942132;5653.038983372795;239109;240079;240149;240163;240596;49344.25983610249;49974.750126249135;55574.16638750422;55852;56404.717976409855;58184.709076454346;58215;58245.70877145672;58315.416845831;58424.70787646034;17881.552961176076;17997.460076197473;18151.183196756177;18171.273149073888;18205.453836384928;15025.549233523012;15183.468578599695;15186.392544298325;15321.46374876874;15341.846581534264;15804.130772807375;15916.602084947737;16085.919570402073;16106.516804495885;16108.436204732778;5895.380984996599;6039.849003774941;6067.787627433018;6071.787487437919;6090.939090609126;1116.849225354583;1120.2998126171144;1122.3490375582144;1128.0806142993433;1128.2666266926399;26486.47027059448;26520.60219096715;26554.6016809748;26587.46825063488;26668;1228.582282024116;1239.1821397877359;1240.3364200153055;1248.3009514671812;1259.1249081888184;13861;13954.372053257628;14042.719145617031;14094.365753541115;14300.85699143016;297740;321027;324711;328459;328578;68142;68489.65755171192;68938.31061689419;69037.3096269041;69501;1577.4321244352025;1583.1530131379657;1583.1688363608966;1591.594143493425;1602.1828867277773;30878.691213087583;31287.68712312848;31475.842620787666;31729.5240571387;32089.839550802095;45316.77341613271;45665.31502027539;45799;45917.54082459266;45934;277819;279886;280205;280380;280473;38410.42384364181;39000.414993774546;39175.216495670495;39754.602453976244;39818.60181398265;48635.27047094367;50124.74937625288;50354;50457.24314135365;50623.74688126536;35219.295614088085;35222.29555408929;35347.82326088353;35502.289954200256;35744.10639733924;35653.28693426169;36105.01422421792;36752.448713269856;36934.63065369312;37034.07414814543;41389.58610413857;42724.35913461239;42876.35685464658;43014;43030.569694302656;33937.83031084829;34135.43984201145;34675.65324346724;34721.652783472855;34888.12779680528;25726;25801.612975805754;25993.350166245997;26160.8691956539;26226.73773262243 14:46:54 INFO - PID 7488 | |2;jquery.html;618.7308520793458;631.8736252749449;634.4321831960395;638.4963750510213;644.8387903024245;24078.277651670454;24457.266282011522;25084.87457562712;25101.49797004061;25540.872295638495;27550.724492755067;28051.158465246026;28068.578971315448;28087.157385278424;28118;6739.595624262535;6895.862082758342;6906.205786334561;6914.032035515032;6935.549189302705;7028.964855175717;7054.82362940928;7056.153261608614;7056.964715176443;7072.328128827753;7029.89455158173;7046.471514636397;7059.258777828331;7064.505484616079;7068.858622827541;7039.577625342496;7042.119735033147;7042.7887163385185;7047.224805271416;7071.82320441993;6551.213854337462;6591.4397276231575;6594.802155935329;6628.966855165693;6636.668166591699;31193.688063119305;31889;32374.6762532374;32395.352092958008;32429.6757032429;2335.9182428614918;2360.421696684306;2364.869932153731;2367.4791545859885;2369.206315884181;19863.40409787694;19917.900410497856;20511;20583.485412864648;20587.279445219345;2657.3755167535614;2682.248970288322;2714.9864250678816;2736.0423851651763;2741.4380052089273;140665.296673517;146286;159160;165710.17144914198;166552;16687.499375018768;17144.742828857576;17477.65044699099;17752.822471775376;17865.910670446825;27907.72092279051;28070.85964570164;28166.155015349574;28182.15453536397;28298.43403131926;11591.84081591834;11620.883791162149;11639.359835209145;11648.70878228034;11751.706207344714;10839;10881.12950963921;10915.290506117077;10919.836202456969;11006.559737610565;10197.111680047783;10231.7442063949;10490.895091049144;10509.31689440184;10537.736556586147;2854.4861924853312;2904.7095290470784;2921.97078029217;2951;3004.3690824926575;1052.2686732720838;1052.489542571852;1066.0778426660881;1076.8923107689168;1079.7516571188514;22513.662295065587;22620.321390357985;22820.65769013466;22877.31368058961;23137.38038337334;1120.8262719278525;1139.8917102875214;1144.6508814811395;1150.413289222486;1163.0463020323255;12304.692382690504;12423.378831058411;12596.748065038648;12654.87345126537;12655.11414200997;654454;661318;671439;674875;690537;142009;142556;142658;143650;146684;1227.6501197158766;1232.3899669663394;1261.6278197931633;1266.3921317767524;1275.1647670775658;19511.80623720107;19862.404127876187;20386.490337741674;20472.897635511727;20501.48746281295;65360;65736.34263657303;66045.66977165084;66542;67839;82021;82166;82208.17791822006;83015;85878;16059.357625694842;16217.270222839765;16378.918105409397;16532.256048478088;16558.337666493688;25055.624165637895;25084.874575627004;25108.874455627603;25128.62307065359;25266.747332527175;20152.697709534077;20334.89832550828;20492.692609611167;20577.38267851967;20597.176112955913;15981.041137531785;16013.199340033185;16274.186290685655;16286.755698664292;17615.295388184328;19422.708659370404;20237.291694790612;20340.288089916783;20369;20457.181712731322;15973.520794375723;16091;16147.838521614634;16167.191640417697;16184.190790460665;19872.403827885188;19997.800021999592;20008.39974800758;20218.89890550538;20249.6962545559 14:46:54 INFO - PID 7488 | |3;mootools.html;1404.115407293405;1465.8607432293934;1470.1693543148126;1482.5774654223544;1483.2435457916458;16977.915110424445;18354.44936651899;18433.446996590108;18491.722624160633;18538.258469661196;18016.279348826032;18278.90860545699;18338.908305458488;18365.173567189475;18408.263669453238;3004.879804807805;3020.7130322619428;3081.9845900770465;3096.938061238774;3100;3032.287412458071;3053.938921221574;3061.5713800068006;3063.831489268089;3067.3558552703958;3000.5199168133104;3017.9547306790414;3036.225762430577;3128.7809853310278;3137.294108825519;3037.271054946808;3044.101989912981;3063.3107550801114;3067.2025273428844;3068.3556453144756;2855.5573886047696;2932.384199318146;2935.354222071141;3000.0549826804704;3007.9097627071224;17194.1402929853;17472.737908931376;17532.737008944878;17580.912095439442;17628.735568966476;8678.696245631436;9043.09569043097;9048.185663290269;9052.547372631341;9053.547322633907;5498.945010549884;5583.6928968906695;5646.604737668324;5687.4881260686325;5705.5435565154685;1929.1222493765304;1937.2251099560149;1949.522367020075;1959.1086055844557;1980.0693673973353;32413.51379729306;32547.83726081378;32668.509972350435;32673;32705.182370440692;7827.569483678339;7902.17027212146;7974.720884769005;8082.434229603989;8125.674973001013;20788.1684732612;20868.373948781562;20994.47513812167;21020.26429074975;21025.89487052555;8920.063393343606;8989.955050224708;9025.819483610423;9060.95469522648;9078.81842363149;8029.558374289353;8105.797355066053;8239.917600823916;8264.504129752235;8342.582870856433;6120.112583675431;6122.938770612326;6141.355157708465;6188.628682279078;6297.1813664223355;1573.795406597135;1614.65284963731;1760.4102625620305;1786.1247988485547;1814.3559036541837;1001.5543083327995;1020.403064207447;1032.0917592518535;1036.8887361611248;1038.402918321968;10154.543045562967;10290.897091029143;10445.373277603368;10448.373097614167;10472.790544189225;839.4082172068677;845.9746207613781;880.4849163239577;942.5240253671852;1111.238801421013;6207.037909124093;6330.936690633127;6530.249021362509;6569.638669873203;6615.834604134935;25532.23403297904;26456.074037408984;26508.204753857415;26658;26696.065637702588;25200.621990670155;25624.48751024969;26342;26378;26661.200163995112;12046.759064818654;12071.758564828655;12170.574029909088;12253.264804111783;12264.81602775959;9592;9604.327697061139;9664.275179361435;9707.417554946725;9721.4653194075;22235.888820555792;22308.442288942908;22340.106395743987;23092.538149237258;23448;23467.530649386576;23481.412964675335;23541;23850.40373990664;23916.64125038091;12570.937145314216;12775.87224127784;12784.424700888296;12794.808077878653;12803.935980320039;16290.42983495572;16340.346386144422;16361.590960226089;16520.66958660796;16592.917035414746;12934.482620695444;13189.208647481182;13252.20486770797;13289.53486628002;13659.86340136586;12993.155444896052;13146.737065258832;13181.736365272833;13208.735825283633;13332.866671333162;11688.824667630162;11833.526658933546;11841.940790295994;11865.347405892759;11877.109216808602;9032.45805251687;9040.864387034331;9058.50178240203;9075.863862041942;9191.218746406363;8989.101089890959;9030.683926062819;9050.411723237969;9151.954240228757;9176.08239176077 14:46:54 INFO - PID 7488 | |4;prototype.html;578.294480733505;599.3137857153562;599.9460048595627;601.8405122642498;607.9756809727611;6329.746810127601;6347.841303967397;6382.393672601102;6449.967750161254;6471.870562588751;6332.435363677718;6341.682915854212;6398.744050237997;6439.130717353156;6463.612183268995;5332.840014799543;5351.839444816662;5359.651622644536;5375.919361209585;5378.489043540857;4981.9750901245625;5190.117679994391;5307.840764777044;5343.332083489564;5355.928814237149;5189.532942035216;5196.636235463519;5197.454267301936;5205.869853253661;5224.346956630421;5122.15484445068;5163.173892177234;5166.948330516722;5169.534741873231;5204.9479505204845;4724.314974328738;4739.834105806281;4748.905021899577;4761.523847615211;4769.618430525549;6274.435300822948;6286.654234017127;6293.444204024711;6319.8736025279695;6327.254559080689;5948.494377977877;5972.372900845436;6041.546883983675;6043.879122417571;6080.787172448943;6701.28597917844;6731.158605174353;6733.6296503692765;6780.050792888999;6786.524943253974;5225.973870130625;5229.50319719626;5247.239150323182;5250.264962905197;5266.34170728659;6772.932270677279;6871.828204294882;6898.241193468764;7020.859582808315;7090.432765378758;5316.468353164652;5363.785448582013;5385.515303622693;5386.946130538723;5431.967926094029;5447.591430642718;5451.863703407367;5463.426340234298;5479.369872464637;5499.945000550023;6032.1856549365275;6032.547558933097;6049.758009679652;6057.818265452043;6099.329073801879;6769.932300677028;6775.593464392054;6843.144606924135;6874.484413668994;6905.551139175937;1830.853531717486;1868.3367404571181;1869.1215128889671;1882.7458293130253;1882.7646544181978;1286.8097010265653;1292.5476083370745;1331.5406184866206;1345.1861623717705;1377.0704774277324;6360.872782544323;6382.712777924911;6385.233771947396;6387.776427825097;6417.8716425672155;6782.1861376635115;6802.863942721118;6811.897821532681;6832.760853370109;6871.793846184622;6360.363963603602;6373.458256048195;6428.453581445536;6452.257990331078;6498.187726534184;3563.768355056913;3604.8017359045502;3618.9638103618627;3636.781793092423;3648.908777280589;6888.586684798928;6998.75504357345;7053.92946070543;7081.92918070823;7107.573545587281;6881.931180688229;6885.1049363582415;6960.6078784243355;7067.010618513412;7139.82150446243;7108.218096009435;7139.535930164523;7214.92785072153;7219.241979592067;7224.880143577754;6748;6774.695138718671;6840.692168852314;6865.670149977157;6875.415589674733;6836.829079273058;6845.726170953106;6910.412614927787;6917;6917.861642767217;7101.7159313628945;7132.750353737594;7226.963865180641;7246.384057355184;7274.636268186464;5356.919646205232;5427.5657947363325;5431.09911530961;5438.673679579238;5445.346558413015;6682.69927853238;6884.829578971687;6967.616781076887;6981.616011119438;7022.578645281299;6528.967355163194;6575.605463672195;6589.8039450865335;6664.70067826599;6750.3924646782025;6560.868782624416;6601.33986601336;6638.800835974928;6680;6720.1599800025;6465.676716164079;6482.384173503699;6519.08732777402;6594.868102638016;6697.799066028027;6639.70121344531;6686.632235226914;6745.831354216184;6807.897881531682;6822.420094292041;6567.802965911031;6586.967065164644;6599.274079851309;6633.800985970429;6649.60102393858 14:46:54 INFO - PID 7488 | |5;yui.html;970.7961328121095;1012.5595366015783;1021.3565453764128;1022.9335093218945;1039.991208527728;20089;20517.17931282747;20568.485787855312;20588.691169632468;20593.48516287092;19579.41261762146;19997.300094496695;20556.177752889867;20777.16891324345;20904.372868813924;1040.8802987656422;1061.3631820907472;1061.6178175856724;1065.1957771882219;1066.306900514664;1035.9171266298679;1067.2955849139569;1081.5025088459317;1083.4257843343041;1084.1651928015424;1139.7435576995151;1140.3044143072761;1141.1270378160714;1141.1726498288715;1141.4178768827917;1120.4229821641861;1130.5251794246435;1138.3852719531444;1140.6863112644007;1142.6457798082579;834.9729832306236;837.9581020948989;838.1116017021976;838.1241602525315;838.6142374507734;18532.888026718305;20424.0809163588;21429.14283428661;21745.782542174533;21802.89098554497;22690.31929042115;22801.543969120525;23271;23283.883580581987;23371.88314058419;18244.817551824446;18318.267269309345;18373.540661483436;18376.816231837776;18417.907910460497;3746.7002639788752;3776.0748616589112;3822.4648549203134;3824.426336049587;3824.9043773905596;143847.28076359656;152833.9999999989;158359;158599;160586.1970690139;18087.457376278733;18266.908665456587;18430.26278948827;18461.7230741539;18481.353152639593;34470.65529344675;34734;35015.4747678785;35049.299014019576;35107.29785404278;9705.6603018894;9737.221022318197;9761.463119528495;9813.460259685644;9826.508674566243;4365.170617582649;4441.578050085237;4445.310976798602;4456.77716114193;4466.531014243523;5993.790217342372;6002.789902353484;6007.939920600738;6036.426539478743;6060;1291.625428625688;1307.1830106183636;1318.240149400542;1318.841738991308;1333.2733660155238;739.9593022383821;755.161770434817;763.4045444553258;771.8919351290824;774.8101715079729;12615.810762838564;12680;12888.80666789999;12979;13063.150895191782;781.1758594682551;791.2641243643352;791.7664289034749;796.681327469017;800.4236949396425;6180.505559555225;6198.597091189058;6292.874142517124;6364.936350636527;6403.00753383217;146155;150493;152857;153183;157441;119714;125857;126391;126865.36567317288;128037;114629;114832;116062;117938;118516;11927.821082683593;12039.699007524881;12099.516019359127;12119.272843629411;12431.564895228623;55167;56276.71861640666;56710;56930.715346423;58147;73380;74901.62549187437;75508;76424.23575764394;76576;14379;14610.853891460949;14835.10989340643;14865.628359291104;14905.776413353591;18673.439796806117;18685.439436816916;18893.527661808566;18940.147693353556;18993.43019709411;19036.809631903503;19236.08374445685;19564.706529402356;19600.117994690558;19679.901600492478;15393.384264629289;15441.613959651098;15597.766033509279;15740.449084281996;15748.133852638215;15150.696986060437;15227.771583426036;15267;15309.693806124038;15372.538823835303;13821.654458638615;13871.543487934025;13925.303734813422;13949.372278247707;14086.506972255922;14053.156810591398;14128.152310861382;14212.502562410265;14293.499727509903;14479.203643799692 14:46:54 INFO - PID 7488 | __end_tp_report 14:46:54 INFO - PID 7488 | __start_cc_report 14:46:54 INFO - PID 7488 | _x_x_mozilla_cycle_collect,252 14:46:54 INFO - PID 7488 | __end_cc_report 14:46:54 INFO - PID 7488 | __startTimestamp1508536014890__endTimestamp 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | ------- Summary: start ------- 14:46:54 INFO - PID 7488 | Number of tests: 6 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#0] dojo.html Cycles:165 Average:6492.65 Median:6750.76 stddev:753.17 (11.2%) stddev-sans-first:729.20 14:46:54 INFO - PID 7488 | Values: 3978.8 3984.4 4023.9 4032.3 4037.0 6358.1 6361.2 6431.8 6457.6 6472.8 6384.0 6414.8 6475.5 6499.8 6502.8 5725.5 5778.5 5826.4 5859.0 5864.6 5689.3 5776.1 5784.8 5790.3 5928.2 5822.8 5909.0 5927.8 5958.8 5963.1 5822.8 5920.3 5978.5 5988.9 6009.3 5739.3 5803.4 5875.7 5894.2 6001.2 6402.1 6433.0 6436.5 6484.9 6495.8 7030.8 7075.1 7116.5 7132.0 7162.0 7029.0 7068.6 7086.4 7147.9 7148.0 6428.4 6515.0 6540.0 6600.8 6656.7 7226.7 7288.7 7301.7 7306.4 7326.5 6908.1 6937.7 6967.9 6979.6 7007.3 6927.0 7053.9 7079.3 7099.5 7107.0 7004.9 7097.9 7098.4 7108.0 7113.1 6995.7 7000.5 7032.5 7083.4 7105.4 5124.9 5133.1 5152.5 5189.9 5207.5 4726.6 4733.0 4772.7 4810.0 4832.6 6663.6 6687.9 6731.1 6735.1 6740.9 6919.5 7014.5 7020.0 7113.5 7113.9 6466.6 6582.7 6588.8 6661.8 6719.4 5809.5 5812.4 5818.1 5822.4 5827.7 7163.1 7179.9 7211.3 7267.2 7286.6 6946.8 6947.3 6959.2 6966.1 7022.5 7284.0 7288.9 7296.2 7309.4 7316.6 6920.3 6924.8 6933.6 6936.0 6950.2 6941.3 6966.9 6979.0 6986.8 7004.1 6667.2 6673.4 6681.9 6763.2 6779.0 6678.5 6721.4 6761.3 6826.2 6827.5 6750.8 6769.3 6796.8 6804.7 6833.1 6873.5 6890.3 6927.2 6931.3 6949.0 6670.9 6673.7 6758.0 6779.3 6779.8 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#1] ext.html Cycles:180 Average:46848.27 Median:21124.13 stddev:73501.88 (348.0%) stddev-sans-first:73627.47 14:46:54 INFO - PID 7488 | Values: 1004.7 1024.1 1026.7 1027.0 1030.6 46897.8 47523.5 47588.3 47682.3 47754.0 44755.6 44993.3 45016.5 45087.8 45119.3 8068.8 8299.0 8398.3 8456.6 8473.2 8810.5 8923.9 8927.9 8928.3 8930.3 8874.8 8920.5 8927.2 8946.0 8965.3 8854.7 8897.4 8915.4 8925.3 8939.6 8515.3 8523.7 8569.9 8573.4 8577.2 43348.6 43440.8 43480.0 43763.1 43867.3 3837.8 3901.6 3903.9 3904.6 3906.6 34005.7 34090.5 34704.1 34912.3 35113.0 5555.9 5595.3 5626.7 5628.3 5653.0 239109.0 240079.0 240149.0 240163.0 240596.0 49344.3 49974.8 55574.2 55852.0 56404.7 58184.7 58215.0 58245.7 58315.4 58424.7 17881.6 17997.5 18151.2 18171.3 18205.5 15025.5 15183.5 15186.4 15321.5 15341.8 15804.1 15916.6 16085.9 16106.5 16108.4 5895.4 6039.8 6067.8 6071.8 6090.9 1116.8 1120.3 1122.3 1128.1 1128.3 26486.5 26520.6 26554.6 26587.5 26668.0 1228.6 1239.2 1240.3 1248.3 1259.1 13861.0 13954.4 14042.7 14094.4 14300.9 297740.0 321027.0 324711.0 328459.0 328578.0 68142.0 68489.7 68938.3 69037.3 69501.0 1577.4 1583.2 1583.2 1591.6 1602.2 30878.7 31287.7 31475.8 31729.5 32089.8 45316.8 45665.3 45799.0 45917.5 45934.0 277819.0 279886.0 280205.0 280380.0 280473.0 38410.4 39000.4 39175.2 39754.6 39818.6 48635.3 50124.7 50354.0 50457.2 50623.7 35219.3 35222.3 35347.8 35502.3 35744.1 35653.3 36105.0 36752.4 36934.6 37034.1 41389.6 42724.4 42876.4 43014.0 43030.6 33937.8 34135.4 34675.7 34721.7 34888.1 25726.0 25801.6 25993.4 26160.9 26226.7 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#2] jquery.html Cycles:180 Average:42766.65 Median:22566.99 stddev:111922.40 (496.0%) stddev-sans-first:112191.63 14:46:54 INFO - PID 7488 | Values: 618.7 631.9 634.4 638.5 644.8 24078.3 24457.3 25084.9 25101.5 25540.9 27550.7 28051.2 28068.6 28087.2 28118.0 6739.6 6895.9 6906.2 6914.0 6935.5 7029.0 7054.8 7056.2 7057.0 7072.3 7029.9 7046.5 7059.3 7064.5 7068.9 7039.6 7042.1 7042.8 7047.2 7071.8 6551.2 6591.4 6594.8 6629.0 6636.7 31193.7 31889.0 32374.7 32395.4 32429.7 2335.9 2360.4 2364.9 2367.5 2369.2 19863.4 19917.9 20511.0 20583.5 20587.3 2657.4 2682.2 2715.0 2736.0 2741.4 140665.3 146286.0 159160.0 165710.2 166552.0 16687.5 17144.7 17477.7 17752.8 17865.9 27907.7 28070.9 28166.2 28182.2 28298.4 11591.8 11620.9 11639.4 11648.7 11751.7 10839.0 10881.1 10915.3 10919.8 11006.6 10197.1 10231.7 10490.9 10509.3 10537.7 2854.5 2904.7 2922.0 2951.0 3004.4 1052.3 1052.5 1066.1 1076.9 1079.8 22513.7 22620.3 22820.7 22877.3 23137.4 1120.8 1139.9 1144.7 1150.4 1163.0 12304.7 12423.4 12596.7 12654.9 12655.1 654454.0 661318.0 671439.0 674875.0 690537.0 142009.0 142556.0 142658.0 143650.0 146684.0 1227.7 1232.4 1261.6 1266.4 1275.2 19511.8 19862.4 20386.5 20472.9 20501.5 65360.0 65736.3 66045.7 66542.0 67839.0 82021.0 82166.0 82208.2 83015.0 85878.0 16059.4 16217.3 16378.9 16532.3 16558.3 25055.6 25084.9 25108.9 25128.6 25266.7 20152.7 20334.9 20492.7 20577.4 20597.2 15981.0 16013.2 16274.2 16286.8 17615.3 19422.7 20237.3 20340.3 20369.0 20457.2 15973.5 16091.0 16147.8 16167.2 16184.2 19872.4 19997.8 20008.4 20218.9 20249.7 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#3] mootools.html Cycles:180 Average:11073.68 Median:26417.04 stddev:8189.55 (31.0%) stddev-sans-first:8180.30 14:46:54 INFO - PID 7488 | Values: 1404.1 1465.9 1470.2 1482.6 1483.2 16977.9 18354.4 18433.4 18491.7 18538.3 18016.3 18278.9 18338.9 18365.2 18408.3 3004.9 3020.7 3082.0 3096.9 3100.0 3032.3 3053.9 3061.6 3063.8 3067.4 3000.5 3018.0 3036.2 3128.8 3137.3 3037.3 3044.1 3063.3 3067.2 3068.4 2855.6 2932.4 2935.4 3000.1 3007.9 17194.1 17472.7 17532.7 17580.9 17628.7 8678.7 9043.1 9048.2 9052.5 9053.5 5498.9 5583.7 5646.6 5687.5 5705.5 1929.1 1937.2 1949.5 1959.1 1980.1 32413.5 32547.8 32668.5 32673.0 32705.2 7827.6 7902.2 7974.7 8082.4 8125.7 20788.2 20868.4 20994.5 21020.3 21025.9 8920.1 8990.0 9025.8 9061.0 9078.8 8029.6 8105.8 8239.9 8264.5 8342.6 6120.1 6122.9 6141.4 6188.6 6297.2 1573.8 1614.7 1760.4 1786.1 1814.4 1001.6 1020.4 1032.1 1036.9 1038.4 10154.5 10290.9 10445.4 10448.4 10472.8 839.4 846.0 880.5 942.5 1111.2 6207.0 6330.9 6530.2 6569.6 6615.8 25532.2 26456.1 26508.2 26658.0 26696.1 25200.6 25624.5 26342.0 26378.0 26661.2 12046.8 12071.8 12170.6 12253.3 12264.8 9592.0 9604.3 9664.3 9707.4 9721.5 22235.9 22308.4 22340.1 23092.5 23448.0 23467.5 23481.4 23541.0 23850.4 23916.6 12570.9 12775.9 12784.4 12794.8 12803.9 16290.4 16340.3 16361.6 16520.7 16592.9 12934.5 13189.2 13252.2 13289.5 13659.9 12993.2 13146.7 13181.7 13208.7 13332.9 11688.8 11833.5 11841.9 11865.3 11877.1 9032.5 9040.9 9058.5 9075.9 9191.2 8989.1 9030.7 9050.4 9152.0 9176.1 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#4] prototype.html Cycles:180 Average:5780.53 Median:6393.26 stddev:1588.54 (24.8%) stddev-sans-first:1544.26 14:46:54 INFO - PID 7488 | Values: 578.3 599.3 599.9 601.8 608.0 6329.7 6347.8 6382.4 6450.0 6471.9 6332.4 6341.7 6398.7 6439.1 6463.6 5332.8 5351.8 5359.7 5375.9 5378.5 4982.0 5190.1 5307.8 5343.3 5355.9 5189.5 5196.6 5197.5 5205.9 5224.3 5122.2 5163.2 5166.9 5169.5 5204.9 4724.3 4739.8 4748.9 4761.5 4769.6 6274.4 6286.7 6293.4 6319.9 6327.3 5948.5 5972.4 6041.5 6043.9 6080.8 6701.3 6731.2 6733.6 6780.1 6786.5 5226.0 5229.5 5247.2 5250.3 5266.3 6772.9 6871.8 6898.2 7020.9 7090.4 5316.5 5363.8 5385.5 5386.9 5432.0 5447.6 5451.9 5463.4 5479.4 5499.9 6032.2 6032.5 6049.8 6057.8 6099.3 6769.9 6775.6 6843.1 6874.5 6905.6 1830.9 1868.3 1869.1 1882.7 1882.8 1286.8 1292.5 1331.5 1345.2 1377.1 6360.9 6382.7 6385.2 6387.8 6417.9 6782.2 6802.9 6811.9 6832.8 6871.8 6360.4 6373.5 6428.5 6452.3 6498.2 3563.8 3604.8 3619.0 3636.8 3648.9 6888.6 6998.8 7053.9 7081.9 7107.6 6881.9 6885.1 6960.6 7067.0 7139.8 7108.2 7139.5 7214.9 7219.2 7224.9 6748.0 6774.7 6840.7 6865.7 6875.4 6836.8 6845.7 6910.4 6917.0 6917.9 7101.7 7132.8 7227.0 7246.4 7274.6 5356.9 5427.6 5431.1 5438.7 5445.3 6682.7 6884.8 6967.6 6981.6 7022.6 6529.0 6575.6 6589.8 6664.7 6750.4 6560.9 6601.3 6638.8 6680.0 6720.2 6465.7 6482.4 6519.1 6594.9 6697.8 6639.7 6686.6 6745.8 6807.9 6822.4 6567.8 6587.0 6599.3 6633.8 6649.6 14:46:54 INFO - PID 7488 | 14:46:54 INFO - PID 7488 | [#5] yui.html Cycles:180 Average:28147.57 Median:18424.09 stddev:41890.63 (227.4%) stddev-sans-first:41958.45 14:46:54 INFO - PID 7488 | Values: 970.8 1012.6 1021.4 1022.9 1040.0 20089.0 20517.2 20568.5 20588.7 20593.5 19579.4 19997.3 20556.2 20777.2 20904.4 1040.9 1061.4 1061.6 1065.2 1066.3 1035.9 1067.3 1081.5 1083.4 1084.2 1139.7 1140.3 1141.1 1141.2 1141.4 1120.4 1130.5 1138.4 1140.7 1142.6 835.0 838.0 838.1 838.1 838.6 18532.9 20424.1 21429.1 21745.8 21802.9 22690.3 22801.5 23271.0 23283.9 23371.9 18244.8 18318.3 18373.5 18376.8 18417.9 3746.7 3776.1 3822.5 3824.4 3824.9 143847.3 152834.0 158359.0 158599.0 160586.2 18087.5 18266.9 18430.3 18461.7 18481.4 34470.7 34734.0 35015.5 35049.3 35107.3 9705.7 9737.2 9761.5 9813.5 9826.5 4365.2 4441.6 4445.3 4456.8 4466.5 5993.8 6002.8 6007.9 6036.4 6060.0 1291.6 1307.2 1318.2 1318.8 1333.3 740.0 755.2 763.4 771.9 774.8 12615.8 12680.0 12888.8 12979.0 13063.2 781.2 791.3 791.8 796.7 800.4 6180.5 6198.6 6292.9 6364.9 6403.0 146155.0 150493.0 152857.0 153183.0 157441.0 119714.0 125857.0 126391.0 126865.4 128037.0 114629.0 114832.0 116062.0 117938.0 118516.0 11927.8 12039.7 12099.5 12119.3 12431.6 55167.0 56276.7 56710.0 56930.7 58147.0 73380.0 74901.6 75508.0 76424.2 76576.0 14379.0 14610.9 14835.1 14865.6 14905.8 18673.4 18685.4 18893.5 18940.1 18993.4 19036.8 19236.1 19564.7 19600.1 19679.9 15393.4 15441.6 15597.8 15740.4 15748.1 15150.7 15227.8 15267.0 15309.7 15372.5 13821.7 13871.5 13925.3 13949.4 14086.5 14053.2 14128.2 14212.5 14293.5 14479.2 14:46:54 INFO - PID 7488 | -------- Summary: end -------- 14:46:54 INFO - PID 7488 | 14:46:55 INFO - TEST-INFO | 7488: exit 0 14:46:55 INFO - TEST-OK | dromaeo_css | took 1106767ms 14:46:55 INFO - TEST-START | kraken 14:46:55 INFO - Initialising browser for kraken test... 14:46:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58063/getInfo.html -profile /tmp/tmpaUNhX_/profile 14:46:55 INFO - TEST-INFO | started process 7850 (/builds/slave/test/build/application/firefox/firefox http://localhost:58063/getInfo.html) 14:47:00 INFO - TEST-INFO | 7850: exit 0 14:47:00 INFO - Browser initialized. 14:47:00 INFO - Running cycle 1/1 for kraken test... 14:47:00 INFO - Using env: {'DISPLAY': ':0', 14:47:00 INFO - 'HOME': '/home/cltbld', 14:47:00 INFO - 'JSGC_DISABLE_POISONING': '1', 14:47:00 INFO - 'LANG': 'en_US.UTF-8', 14:47:00 INFO - 'LANGUAGE': 'en_US:en', 14:47:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:47:00 INFO - 'LOGNAME': 'cltbld', 14:47:00 INFO - 'MAIL': '/var/mail/cltbld', 14:47:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:47:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:47:00 INFO - 'MOZ_CRASHREPORTER': '1', 14:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:47:00 INFO - 'MOZ_NO_REMOTE': '1', 14:47:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:00 INFO - 'NO_EM_RESTART': '1', 14:47:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:00 INFO - 'PWD': '/builds/slave/test', 14:47:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:47:00 INFO - 'RUST_BACKTRACE': 'full', 14:47:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:47:00 INFO - 'SHELL': '/bin/bash', 14:47:00 INFO - 'SHLVL': '1', 14:47:00 INFO - 'TERM': 'linux', 14:47:00 INFO - 'TMOUT': '86400', 14:47:00 INFO - 'USER': 'cltbld', 14:47:00 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922', 14:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:00 INFO - '_': '/tools/buildbot/bin/python'} 14:47:00 INFO - TEST-INFO | started process 8081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUNhX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:01 INFO - PID 8081 | 14:47:01 INFO - PID 8081 | (/builds/slave/test/build/application/firefox/firefox:8130): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:47:01 INFO - PID 8081 | 14:47:11 INFO - PID 8081 | RSS: Main: 143568896 14:47:11 INFO - PID 8081 | 14:47:13 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58063/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:14 INFO - PID 8081 | RSS: Main: 149475328 14:47:14 INFO - PID 8081 | 14:47:17 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58063/tests/kraken/driver.html?testName=audio-dft) 14:47:17 INFO - PID 8081 | RSS: Main: 149897216 14:47:17 INFO - PID 8081 | 14:47:20 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58063/tests/kraken/driver.html?testName=audio-fft) 14:47:21 INFO - PID 8081 | RSS: Main: 151232512 14:47:21 INFO - PID 8081 | 14:47:23 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58063/tests/kraken/driver.html?testName=audio-oscillator) 14:47:23 INFO - PID 8081 | RSS: Main: 150900736 14:47:23 INFO - PID 8081 | 14:47:25 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:26 INFO - PID 8081 | RSS: Main: 150827008 14:47:26 INFO - PID 8081 | 14:47:29 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58063/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:30 INFO - PID 8081 | RSS: Main: 150564864 14:47:30 INFO - PID 8081 | 14:47:33 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58063/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:34 INFO - PID 8081 | RSS: Main: 153333760 14:47:34 INFO - PID 8081 | 14:47:36 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58063/tests/kraken/driver.html?testName=json-parse-financial) 14:47:37 INFO - PID 8081 | RSS: Main: 153944064 14:47:37 INFO - PID 8081 | 14:47:39 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:39 INFO - PID 8081 | RSS: Main: 153444352 14:47:39 INFO - PID 8081 | 14:47:41 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:41 INFO - PID 8081 | RSS: Main: 153604096 14:47:41 INFO - PID 8081 | 14:47:43 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:44 INFO - PID 8081 | RSS: Main: 150913024 14:47:44 INFO - PID 8081 | 14:47:46 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:47 INFO - PID 8081 | RSS: Main: 150360064 14:47:47 INFO - PID 8081 | 14:47:50 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:50 INFO - PID 8081 | RSS: Main: 150958080 14:47:50 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:58063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58063/tests/kraken/driver.html?testName=ai-astar) 14:47:52 INFO - PID 8081 | RSS: Main: 152571904 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | __start_tp_report 14:47:52 INFO - PID 8081 | _x_x_mozilla_page_load 14:47:52 INFO - PID 8081 | _x_x_mozilla_page_load_details 14:47:52 INFO - PID 8081 | |i|pagename|runs| 14:47:52 INFO - PID 8081 | |0;ai-astar;107;105;105;104;106;108;105;105;105;105 14:47:52 INFO - PID 8081 | |1;audio-beat-detection;114;113;110;115;113;113;111;138;112;114 14:47:52 INFO - PID 8081 | |2;audio-dft;162;163;163;160;160;161;162;162;163;161 14:47:52 INFO - PID 8081 | |3;audio-fft;75;73;74;74;74;73;74;72;72;75 14:47:52 INFO - PID 8081 | |4;audio-oscillator;78;78;78;78;79;78;77;77;77;77 14:47:52 INFO - PID 8081 | |5;imaging-gaussian-blur;110;114;109;114;114;115;114;111;113;114 14:47:52 INFO - PID 8081 | |6;imaging-darkroom;148;150;148;149;149;149;148;151;150;149 14:47:52 INFO - PID 8081 | |7;imaging-desaturate;94;93;94;94;94;95;94;94;94;94 14:47:52 INFO - PID 8081 | |8;json-parse-financial;43;45;43;44;43;44;44;43;44;42 14:47:52 INFO - PID 8081 | |9;json-stringify-tinderbox;38;39;38;38;38;38;39;39;38;38 14:47:52 INFO - PID 8081 | |10;stanford-crypto-aes;70;75;70;70;71;71;70;69;69;70 14:47:52 INFO - PID 8081 | |11;stanford-crypto-ccm;103;103;105;113;107;107;98;106;102;104 14:47:52 INFO - PID 8081 | |12;stanford-crypto-pbkdf2;148;146;150;155;150;157;149;149;154;150 14:47:52 INFO - PID 8081 | |13;stanford-crypto-sha256-iterative;61;58;60;60;60;61;59;61;61;58 14:47:52 INFO - PID 8081 | __end_tp_report 14:47:52 INFO - PID 8081 | __start_cc_report 14:47:52 INFO - PID 8081 | _x_x_mozilla_cycle_collect,690 14:47:52 INFO - PID 8081 | __end_cc_report 14:47:52 INFO - PID 8081 | __startTimestamp1508536072636__endTimestamp 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | ------- Summary: start ------- 14:47:52 INFO - PID 8081 | Number of tests: 14 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.00 stddev:1.18 (1.1%) stddev-sans-first:1.12 14:47:52 INFO - PID 8081 | Values: 107.0 105.0 105.0 104.0 106.0 108.0 105.0 105.0 105.0 105.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#1] audio-beat-detection Cycles:10 Average:115.30 Median:113.50 stddev:8.11 (7.1%) stddev-sans-first:8.59 14:47:52 INFO - PID 8081 | Values: 114.0 113.0 110.0 115.0 113.0 113.0 111.0 138.0 112.0 114.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 14:47:52 INFO - PID 8081 | Values: 162.0 163.0 163.0 160.0 160.0 161.0 162.0 162.0 163.0 161.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#3] audio-fft Cycles:10 Average:73.60 Median:74.00 stddev:1.07 (1.5%) stddev-sans-first:1.01 14:47:52 INFO - PID 8081 | Values: 75.0 73.0 74.0 74.0 74.0 73.0 74.0 72.0 72.0 75.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 14:47:52 INFO - PID 8081 | Values: 78.0 78.0 78.0 78.0 79.0 78.0 77.0 77.0 77.0 77.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:114.00 stddev:2.04 (1.8%) stddev-sans-first:1.90 14:47:52 INFO - PID 8081 | Values: 110.0 114.0 109.0 114.0 114.0 115.0 114.0 111.0 113.0 114.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 14:47:52 INFO - PID 8081 | Values: 148.0 150.0 148.0 149.0 149.0 149.0 148.0 151.0 150.0 149.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:47:52 INFO - PID 8081 | Values: 94.0 93.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:44.00 stddev:0.85 (1.9%) stddev-sans-first:0.88 14:47:52 INFO - PID 8081 | Values: 43.0 45.0 43.0 44.0 43.0 44.0 44.0 43.0 44.0 42.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 14:47:52 INFO - PID 8081 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 39.0 39.0 38.0 38.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.00 stddev:1.72 (2.5%) stddev-sans-first:1.81 14:47:52 INFO - PID 8081 | Values: 70.0 75.0 70.0 70.0 71.0 71.0 70.0 69.0 69.0 70.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#11] stanford-crypto-ccm Cycles:10 Average:104.80 Median:106.50 stddev:3.94 (3.7%) stddev-sans-first:4.12 14:47:52 INFO - PID 8081 | Values: 103.0 103.0 105.0 113.0 107.0 107.0 98.0 106.0 102.0 104.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:150.00 stddev:3.43 (2.3%) stddev-sans-first:3.48 14:47:52 INFO - PID 8081 | Values: 148.0 146.0 150.0 155.0 150.0 157.0 149.0 149.0 154.0 150.0 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.50 stddev:1.20 (2.0%) stddev-sans-first:1.20 14:47:52 INFO - PID 8081 | Values: 61.0 58.0 60.0 60.0 60.0 61.0 59.0 61.0 61.0 58.0 14:47:52 INFO - PID 8081 | -------- Summary: end -------- 14:47:52 INFO - PID 8081 | 14:47:52 INFO - PID 8081 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:47:53 INFO - TEST-INFO | 8081: exit 0 14:47:53 INFO - TEST-OK | kraken | took 57781ms 14:47:53 INFO - SUITE-END | took 1164s 14:47:53 INFO - Completed test suite (00:19:24) 14:47:53 INFO - javascript benchmark 14:47:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9423.221544494114, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3978.7811670358137, 3984.3824207247876, 4023.939640905387, 4032.2540330038946, 4036.979815100924, 6358.109864618957, 6361.2048493938255, 6431.774887878925, 6457.580257283279, 6472.805815825527, 6384.042393640944, 6414.807555773335, 6475.514336424775, 6499.80500584982, 6502.80491585252, 5725.456081672255, 5778.508826749731, 5826.359100498942, 5859.0, 5864.618799778023, 5689.345725241588, 5776.104703770901, 5784.797532086378, 5790.276215473066, 5928.2293301870695, 5822.82531524055, 5909.0, 5927.762889484416, 5958.79144229952, 5963.135345374918, 5822.796202132948, 5920.348761636216, 5978.521718262528, 5988.940110598904, 6009.308929473101, 5739.282589676291, 5803.448672376117, 5875.676837773921, 5894.204282421904, 6001.1898393717165, 6402.13571167891, 6432.967835160841, 6436.517261205381, 6484.93515064848, 6495.837604059889, 7030.753923612649, 7075.115610548682, 7116.537425067354, 7132.0, 7162.0, 7029.0, 7068.646567671647, 7086.3976561992295, 7147.892781608228, 7147.964260178718, 6428.4214420702365, 6515.0, 6540.0, 6600.834979125512, 6656.700448479878, 7226.710931562784, 7288.70845166198, 7301.744438944612, 7306.378957788541, 7326.450516211199, 6908.1364829396325, 6937.653117344113, 6967.860642787217, 6979.581225126407, 7007.334303241184, 6926.960955856662, 7053.858922821515, 7079.327463891025, 7099.503034787618, 7107.040549525851, 7004.92995070053, 7097.89353159703, 7098.36114749675, 7108.0048793169, 7113.146422429341, 6995.650217489207, 7000.474964377692, 7032.472564557678, 7083.397911177608, 7105.396041336544, 5124.92312615311, 5133.050385678586, 5152.4847515248175, 5189.870253243699, 5207.453217412193, 4726.598239149642, 4732.95267047332, 4772.689775164603, 4810.0, 4832.637552183601, 6663.633500157441, 6687.899681504781, 6731.091302674175, 6735.057092007123, 6740.898886516707, 6919.481038922101, 7014.473914456335, 7019.982102595095, 7113.502054856214, 7113.92886071143, 6466.579672321284, 6582.736690532421, 6588.769393071219, 6661.833454163685, 6719.395254427125, 5809.535237181015, 5812.447817457335, 5818.127280907897, 5822.417758224144, 5827.737751801179, 7163.06880105583, 7179.92820071803, 7211.278872112747, 7267.164276108315, 7286.599237041907, 6946.756863509753, 6947.270536593787, 6959.164900212007, 6966.094407726963, 7022.473314501535, 7283.963580182065, 7288.854222915618, 7296.19741828409, 7309.415246780139, 7316.561006339637, 6920.273371295942, 6924.826879327856, 6933.583984960716, 6935.994280829151, 6950.235474097744, 6941.271166527644, 6966.895496567657, 6978.965105174441, 6986.755463558751, 7004.124484439445, 6667.233268174222, 6673.432758215606, 6681.899771503528, 6763.154605674291, 6778.966105169443, 6678.532502724957, 6721.361470660279, 6761.290064543152, 6826.214985276757, 6827.453803695792, 6750.763723269662, 6769.28922463154, 6796.76211332601, 6804.727810887707, 6833.077534532973, 6873.450123990169, 6890.31096890307, 6927.238003819677, 6931.341522555349, 6949.0, 6670.899936501053, 6673.699683514156, 6758.0, 6779.288174741779, 6779.779639664907], "value": 6442.535680426657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1004.6935684616194, 1024.0732137415637, 1026.6509386808484, 1026.973026973027, 1030.634124885666, 46897.76551117244, 47523.52476475234, 47588.286175707304, 47682.28476572846, 47754.0, 44755.55244447554, 44993.325100123526, 45016.549834501646, 45087.774561127146, 45119.32321015187, 8068.798280042987, 8298.958505207465, 8398.286145677625, 8456.577171141449, 8473.237408633222, 8810.515421651806, 8923.910760892406, 8927.910720892773, 8928.330375221853, 8930.330225233101, 8874.778130546756, 8920.464772113693, 8927.241184499326, 8946.0, 8965.282777377794, 8854.690085846996, 8897.377183597151, 8915.375923685344, 8925.28597712188, 8939.642414303453, 8515.318774498088, 8523.74428767138, 8569.914300856974, 8573.399862009663, 8577.228049475578, 43348.566514335085, 43440.78279608613, 43480.0, 43763.12473750539, 43867.341989870176, 3837.827297771607, 3901.648851603369, 3903.941440878389, 3904.590018048121, 3906.628870257321, 34005.6599434005, 34090.48864267038, 34704.13239669003, 34912.30175396503, 35113.0, 5555.861103472405, 5595.300587426572, 5626.690532020737, 5628.296462942132, 5653.038983372795, 239109.0, 240079.0, 240149.0, 240163.0, 240596.0, 49344.25983610249, 49974.750126249135, 55574.16638750422, 55852.0, 56404.717976409855, 58184.709076454346, 58215.0, 58245.70877145672, 58315.416845831, 58424.70787646034, 17881.552961176076, 17997.460076197473, 18151.183196756177, 18171.273149073888, 18205.453836384928, 15025.549233523012, 15183.468578599695, 15186.392544298325, 15321.46374876874, 15341.846581534264, 15804.130772807375, 15916.602084947737, 16085.919570402073, 16106.516804495885, 16108.436204732778, 5895.380984996599, 6039.849003774941, 6067.787627433018, 6071.787487437919, 6090.939090609126, 1116.849225354583, 1120.2998126171144, 1122.3490375582144, 1128.0806142993433, 1128.2666266926399, 26486.47027059448, 26520.60219096715, 26554.6016809748, 26587.46825063488, 26668.0, 1228.582282024116, 1239.1821397877359, 1240.3364200153055, 1248.3009514671812, 1259.1249081888184, 13861.0, 13954.372053257628, 14042.719145617031, 14094.365753541115, 14300.85699143016, 297740.0, 321027.0, 324711.0, 328459.0, 328578.0, 68142.0, 68489.65755171192, 68938.31061689419, 69037.3096269041, 69501.0, 1577.4321244352025, 1583.1530131379657, 1583.1688363608966, 1591.594143493425, 1602.1828867277773, 30878.691213087583, 31287.68712312848, 31475.842620787666, 31729.5240571387, 32089.839550802095, 45316.77341613271, 45665.31502027539, 45799.0, 45917.54082459266, 45934.0, 277819.0, 279886.0, 280205.0, 280380.0, 280473.0, 38410.42384364181, 39000.414993774546, 39175.216495670495, 39754.602453976244, 39818.60181398265, 48635.27047094367, 50124.74937625288, 50354.0, 50457.24314135365, 50623.74688126536, 35219.295614088085, 35222.29555408929, 35347.82326088353, 35502.289954200256, 35744.10639733924, 35653.28693426169, 36105.01422421792, 36752.448713269856, 36934.63065369312, 37034.07414814543, 41389.58610413857, 42724.35913461239, 42876.35685464658, 43014.0, 43030.569694302656, 33937.83031084829, 34135.43984201145, 34675.65324346724, 34721.652783472855, 34888.12779680528, 25726.0, 25801.612975805754, 25993.350166245997, 26160.8691956539, 26226.73773262243], "value": 19838.870073205442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.7308520793458, 631.8736252749449, 634.4321831960395, 638.4963750510213, 644.8387903024245, 24078.277651670454, 24457.266282011522, 25084.87457562712, 25101.49797004061, 25540.872295638495, 27550.724492755067, 28051.158465246026, 28068.578971315448, 28087.157385278424, 28118.0, 6739.595624262535, 6895.862082758342, 6906.205786334561, 6914.032035515032, 6935.549189302705, 7028.964855175717, 7054.82362940928, 7056.153261608614, 7056.964715176443, 7072.328128827753, 7029.89455158173, 7046.471514636397, 7059.258777828331, 7064.505484616079, 7068.858622827541, 7039.577625342496, 7042.119735033147, 7042.7887163385185, 7047.224805271416, 7071.82320441993, 6551.213854337462, 6591.4397276231575, 6594.802155935329, 6628.966855165693, 6636.668166591699, 31193.688063119305, 31889.0, 32374.6762532374, 32395.352092958008, 32429.6757032429, 2335.9182428614918, 2360.421696684306, 2364.869932153731, 2367.4791545859885, 2369.206315884181, 19863.40409787694, 19917.900410497856, 20511.0, 20583.485412864648, 20587.279445219345, 2657.3755167535614, 2682.248970288322, 2714.9864250678816, 2736.0423851651763, 2741.4380052089273, 140665.296673517, 146286.0, 159160.0, 165710.17144914198, 166552.0, 16687.499375018768, 17144.742828857576, 17477.65044699099, 17752.822471775376, 17865.910670446825, 27907.72092279051, 28070.85964570164, 28166.155015349574, 28182.15453536397, 28298.43403131926, 11591.84081591834, 11620.883791162149, 11639.359835209145, 11648.70878228034, 11751.706207344714, 10839.0, 10881.12950963921, 10915.290506117077, 10919.836202456969, 11006.559737610565, 10197.111680047783, 10231.7442063949, 10490.895091049144, 10509.31689440184, 10537.736556586147, 2854.4861924853312, 2904.7095290470784, 2921.97078029217, 2951.0, 3004.3690824926575, 1052.2686732720838, 1052.489542571852, 1066.0778426660881, 1076.8923107689168, 1079.7516571188514, 22513.662295065587, 22620.321390357985, 22820.65769013466, 22877.31368058961, 23137.38038337334, 1120.8262719278525, 1139.8917102875214, 1144.6508814811395, 1150.413289222486, 1163.0463020323255, 12304.692382690504, 12423.378831058411, 12596.748065038648, 12654.87345126537, 12655.11414200997, 654454.0, 661318.0, 671439.0, 674875.0, 690537.0, 142009.0, 142556.0, 142658.0, 143650.0, 146684.0, 1227.6501197158766, 1232.3899669663394, 1261.6278197931633, 1266.3921317767524, 1275.1647670775658, 19511.80623720107, 19862.404127876187, 20386.490337741674, 20472.897635511727, 20501.48746281295, 65360.0, 65736.34263657303, 66045.66977165084, 66542.0, 67839.0, 82021.0, 82166.0, 82208.17791822006, 83015.0, 85878.0, 16059.357625694842, 16217.270222839765, 16378.918105409397, 16532.256048478088, 16558.337666493688, 25055.624165637895, 25084.874575627004, 25108.874455627603, 25128.62307065359, 25266.747332527175, 20152.697709534077, 20334.89832550828, 20492.692609611167, 20577.38267851967, 20597.176112955913, 15981.041137531785, 16013.199340033185, 16274.186290685655, 16286.755698664292, 17615.295388184328, 19422.708659370404, 20237.291694790612, 20340.288089916783, 20369.0, 20457.181712731322, 15973.520794375723, 16091.0, 16147.838521614634, 16167.191640417697, 16184.190790460665, 19872.403827885188, 19997.800021999592, 20008.39974800758, 20218.89890550538, 20249.6962545559], "value": 13384.156420077214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.115407293405, 1465.8607432293934, 1470.1693543148126, 1482.5774654223544, 1483.2435457916458, 16977.915110424445, 18354.44936651899, 18433.446996590108, 18491.722624160633, 18538.258469661196, 18016.279348826032, 18278.90860545699, 18338.908305458488, 18365.173567189475, 18408.263669453238, 3004.879804807805, 3020.7130322619428, 3081.9845900770465, 3096.938061238774, 3100.0, 3032.287412458071, 3053.938921221574, 3061.5713800068006, 3063.831489268089, 3067.3558552703958, 3000.5199168133104, 3017.9547306790414, 3036.225762430577, 3128.7809853310278, 3137.294108825519, 3037.271054946808, 3044.101989912981, 3063.3107550801114, 3067.2025273428844, 3068.3556453144756, 2855.5573886047696, 2932.384199318146, 2935.354222071141, 3000.0549826804704, 3007.9097627071224, 17194.1402929853, 17472.737908931376, 17532.737008944878, 17580.912095439442, 17628.735568966476, 8678.696245631436, 9043.09569043097, 9048.185663290269, 9052.547372631341, 9053.547322633907, 5498.945010549884, 5583.6928968906695, 5646.604737668324, 5687.4881260686325, 5705.5435565154685, 1929.1222493765304, 1937.2251099560149, 1949.522367020075, 1959.1086055844557, 1980.0693673973353, 32413.51379729306, 32547.83726081378, 32668.509972350435, 32673.0, 32705.182370440692, 7827.569483678339, 7902.17027212146, 7974.720884769005, 8082.434229603989, 8125.674973001013, 20788.1684732612, 20868.373948781562, 20994.47513812167, 21020.26429074975, 21025.89487052555, 8920.063393343606, 8989.955050224708, 9025.819483610423, 9060.95469522648, 9078.81842363149, 8029.558374289353, 8105.797355066053, 8239.917600823916, 8264.504129752235, 8342.582870856433, 6120.112583675431, 6122.938770612326, 6141.355157708465, 6188.628682279078, 6297.1813664223355, 1573.795406597135, 1614.65284963731, 1760.4102625620305, 1786.1247988485547, 1814.3559036541837, 1001.5543083327995, 1020.403064207447, 1032.0917592518535, 1036.8887361611248, 1038.402918321968, 10154.543045562967, 10290.897091029143, 10445.373277603368, 10448.373097614167, 10472.790544189225, 839.4082172068677, 845.9746207613781, 880.4849163239577, 942.5240253671852, 1111.238801421013, 6207.037909124093, 6330.936690633127, 6530.249021362509, 6569.638669873203, 6615.834604134935, 25532.23403297904, 26456.074037408984, 26508.204753857415, 26658.0, 26696.065637702588, 25200.621990670155, 25624.48751024969, 26342.0, 26378.0, 26661.200163995112, 12046.759064818654, 12071.758564828655, 12170.574029909088, 12253.264804111783, 12264.81602775959, 9592.0, 9604.327697061139, 9664.275179361435, 9707.417554946725, 9721.4653194075, 22235.888820555792, 22308.442288942908, 22340.106395743987, 23092.538149237258, 23448.0, 23467.530649386576, 23481.412964675335, 23541.0, 23850.40373990664, 23916.64125038091, 12570.937145314216, 12775.87224127784, 12784.424700888296, 12794.808077878653, 12803.935980320039, 16290.42983495572, 16340.346386144422, 16361.590960226089, 16520.66958660796, 16592.917035414746, 12934.482620695444, 13189.208647481182, 13252.20486770797, 13289.53486628002, 13659.86340136586, 12993.155444896052, 13146.737065258832, 13181.736365272833, 13208.735825283633, 13332.866671333162, 11688.824667630162, 11833.526658933546, 11841.940790295994, 11865.347405892759, 11877.109216808602, 9032.45805251687, 9040.864387034331, 9058.50178240203, 9075.863862041942, 9191.218746406363, 8989.101089890959, 9030.683926062819, 9050.411723237969, 9151.954240228757, 9176.08239176077], "value": 7719.553264896152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.294480733505, 599.3137857153562, 599.9460048595627, 601.8405122642498, 607.9756809727611, 6329.746810127601, 6347.841303967397, 6382.393672601102, 6449.967750161254, 6471.870562588751, 6332.435363677718, 6341.682915854212, 6398.744050237997, 6439.130717353156, 6463.612183268995, 5332.840014799543, 5351.839444816662, 5359.651622644536, 5375.919361209585, 5378.489043540857, 4981.9750901245625, 5190.117679994391, 5307.840764777044, 5343.332083489564, 5355.928814237149, 5189.532942035216, 5196.636235463519, 5197.454267301936, 5205.869853253661, 5224.346956630421, 5122.15484445068, 5163.173892177234, 5166.948330516722, 5169.534741873231, 5204.9479505204845, 4724.314974328738, 4739.834105806281, 4748.905021899577, 4761.523847615211, 4769.618430525549, 6274.435300822948, 6286.654234017127, 6293.444204024711, 6319.8736025279695, 6327.254559080689, 5948.494377977877, 5972.372900845436, 6041.546883983675, 6043.879122417571, 6080.787172448943, 6701.28597917844, 6731.158605174353, 6733.6296503692765, 6780.050792888999, 6786.524943253974, 5225.973870130625, 5229.50319719626, 5247.239150323182, 5250.264962905197, 5266.34170728659, 6772.932270677279, 6871.828204294882, 6898.241193468764, 7020.859582808315, 7090.432765378758, 5316.468353164652, 5363.785448582013, 5385.515303622693, 5386.946130538723, 5431.967926094029, 5447.591430642718, 5451.863703407367, 5463.426340234298, 5479.369872464637, 5499.945000550023, 6032.1856549365275, 6032.547558933097, 6049.758009679652, 6057.818265452043, 6099.329073801879, 6769.932300677028, 6775.593464392054, 6843.144606924135, 6874.484413668994, 6905.551139175937, 1830.853531717486, 1868.3367404571181, 1869.1215128889671, 1882.7458293130253, 1882.7646544181978, 1286.8097010265653, 1292.5476083370745, 1331.5406184866206, 1345.1861623717705, 1377.0704774277324, 6360.872782544323, 6382.712777924911, 6385.233771947396, 6387.776427825097, 6417.8716425672155, 6782.1861376635115, 6802.863942721118, 6811.897821532681, 6832.760853370109, 6871.793846184622, 6360.363963603602, 6373.458256048195, 6428.453581445536, 6452.257990331078, 6498.187726534184, 3563.768355056913, 3604.8017359045502, 3618.9638103618627, 3636.781793092423, 3648.908777280589, 6888.586684798928, 6998.75504357345, 7053.92946070543, 7081.92918070823, 7107.573545587281, 6881.931180688229, 6885.1049363582415, 6960.6078784243355, 7067.010618513412, 7139.82150446243, 7108.218096009435, 7139.535930164523, 7214.92785072153, 7219.241979592067, 7224.880143577754, 6748.0, 6774.695138718671, 6840.692168852314, 6865.670149977157, 6875.415589674733, 6836.829079273058, 6845.726170953106, 6910.412614927787, 6917.0, 6917.861642767217, 7101.7159313628945, 7132.750353737594, 7226.963865180641, 7246.384057355184, 7274.636268186464, 5356.919646205232, 5427.5657947363325, 5431.09911530961, 5438.673679579238, 5445.346558413015, 6682.69927853238, 6884.829578971687, 6967.616781076887, 6981.616011119438, 7022.578645281299, 6528.967355163194, 6575.605463672195, 6589.8039450865335, 6664.70067826599, 6750.3924646782025, 6560.868782624416, 6601.33986601336, 6638.800835974928, 6680.0, 6720.1599800025, 6465.676716164079, 6482.384173503699, 6519.08732777402, 6594.868102638016, 6697.799066028027, 6639.70121344531, 6686.632235226914, 6745.831354216184, 6807.897881531682, 6822.420094292041, 6567.802965911031, 6586.967065164644, 6599.274079851309, 6633.800985970429, 6649.60102393858], "value": 5326.770949223462, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.7961328121095, 1012.5595366015783, 1021.3565453764128, 1022.9335093218945, 1039.991208527728, 20089.0, 20517.17931282747, 20568.485787855312, 20588.691169632468, 20593.48516287092, 19579.41261762146, 19997.300094496695, 20556.177752889867, 20777.16891324345, 20904.372868813924, 1040.8802987656422, 1061.3631820907472, 1061.6178175856724, 1065.1957771882219, 1066.306900514664, 1035.9171266298679, 1067.2955849139569, 1081.5025088459317, 1083.4257843343041, 1084.1651928015424, 1139.7435576995151, 1140.3044143072761, 1141.1270378160714, 1141.1726498288715, 1141.4178768827917, 1120.4229821641861, 1130.5251794246435, 1138.3852719531444, 1140.6863112644007, 1142.6457798082579, 834.9729832306236, 837.9581020948989, 838.1116017021976, 838.1241602525315, 838.6142374507734, 18532.888026718305, 20424.0809163588, 21429.14283428661, 21745.782542174533, 21802.89098554497, 22690.31929042115, 22801.543969120525, 23271.0, 23283.883580581987, 23371.88314058419, 18244.817551824446, 18318.267269309345, 18373.540661483436, 18376.816231837776, 18417.907910460497, 3746.7002639788752, 3776.0748616589112, 3822.4648549203134, 3824.426336049587, 3824.9043773905596, 143847.28076359656, 152833.9999999989, 158359.0, 158599.0, 160586.1970690139, 18087.457376278733, 18266.908665456587, 18430.26278948827, 18461.7230741539, 18481.353152639593, 34470.65529344675, 34734.0, 35015.4747678785, 35049.299014019576, 35107.29785404278, 9705.6603018894, 9737.221022318197, 9761.463119528495, 9813.460259685644, 9826.508674566243, 4365.170617582649, 4441.578050085237, 4445.310976798602, 4456.77716114193, 4466.531014243523, 5993.790217342372, 6002.789902353484, 6007.939920600738, 6036.426539478743, 6060.0, 1291.625428625688, 1307.1830106183636, 1318.240149400542, 1318.841738991308, 1333.2733660155238, 739.9593022383821, 755.161770434817, 763.4045444553258, 771.8919351290824, 774.8101715079729, 12615.810762838564, 12680.0, 12888.80666789999, 12979.0, 13063.150895191782, 781.1758594682551, 791.2641243643352, 791.7664289034749, 796.681327469017, 800.4236949396425, 6180.505559555225, 6198.597091189058, 6292.874142517124, 6364.936350636527, 6403.00753383217, 146155.0, 150493.0, 152857.0, 153183.0, 157441.0, 119714.0, 125857.0, 126391.0, 126865.36567317288, 128037.0, 114629.0, 114832.0, 116062.0, 117938.0, 118516.0, 11927.821082683593, 12039.699007524881, 12099.516019359127, 12119.272843629411, 12431.564895228623, 55167.0, 56276.71861640666, 56710.0, 56930.715346423, 58147.0, 73380.0, 74901.62549187437, 75508.0, 76424.23575764394, 76576.0, 14379.0, 14610.853891460949, 14835.10989340643, 14865.628359291104, 14905.776413353591, 18673.439796806117, 18685.439436816916, 18893.527661808566, 18940.147693353556, 18993.43019709411, 19036.809631903503, 19236.08374445685, 19564.706529402356, 19600.117994690558, 19679.901600492478, 15393.384264629289, 15441.613959651098, 15597.766033509279, 15740.449084281996, 15748.133852638215, 15150.696986060437, 15227.771583426036, 15267.0, 15309.693806124038, 15372.538823835303, 13821.654458638615, 13871.543487934025, 13925.303734813422, 13949.372278247707, 14086.506972255922, 14053.156810591398, 14128.152310861382, 14212.502562410265, 14293.499727509903, 14479.203643799692], "value": 9952.88091113744, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 104.0, 106.0, 108.0, 105.0, 105.0, 105.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 115.0, 113.0, 113.0, 111.0, 138.0, 112.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 160.0, 160.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 74.0, 73.0, 74.0, 72.0, 72.0, 75.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 77.0, 77.0, 77.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 109.0, 114.0, 114.0, 115.0, 114.0, 111.0, 113.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 149.0, 149.0, 149.0, 148.0, 151.0, 150.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 43.0, 44.0, 43.0, 44.0, 44.0, 43.0, 44.0, 42.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 70.0, 70.0, 71.0, 71.0, 70.0, 69.0, 69.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 105.0, 113.0, 107.0, 107.0, 98.0, 106.0, 102.0, 104.0], "value": 104.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 150.0, 155.0, 150.0, 157.0, 149.0, 149.0, 154.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 60.0, 60.0, 60.0, 61.0, 59.0, 61.0, 61.0, 58.0], "value": 59.9, "unit": "score"}]}]} 14:47:53 INFO - Return code: 0 14:47:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:53 INFO - # TBPL SUCCESS # 14:47:53 INFO - Running post-action listener: _package_coverage_data 14:47:53 INFO - Running post-action listener: _resource_record_post_action 14:47:53 INFO - [mozharness: 2017-10-20 21:47:53.450597Z] Finished run-tests step (success) 14:47:53 INFO - Running post-run listener: _resource_record_post_run 14:47:53 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292167680; Read time: 16; Write time: 141272 14:47:53 INFO - TinderboxPrint: CPU usage
13.0% 14:47:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:47:53 INFO - TinderboxPrint: I/O write bytes / time
292,167,680 / 141,272 14:47:53 INFO - TinderboxPrint: CPU idle
8,180.4 (86.9%) 14:47:53 INFO - TinderboxPrint: CPU user
1,179.6 (12.5%) 14:47:53 INFO - TinderboxPrint: Swap in / out
0 / 0 14:47:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9703424; Read time: 0; Write time: 852 14:47:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:47:53 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282464256; Read time: 16; Write time: 140420 14:47:54 INFO - Running post-run listener: _upload_blobber_files 14:47:54 INFO - Blob upload gear active. 14:47:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:47:54 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:55 INFO - (blobuploader) - INFO - Done attempting. 14:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:56 INFO - (blobuploader) - INFO - Done attempting. 14:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:57 INFO - (blobuploader) - INFO - Done attempting. 14:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:01 INFO - (blobuploader) - INFO - Done attempting. 14:48:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:01 INFO - Return code: 0 14:48:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9de2487bb24e373756d5571c6ebf9928e99b11e0eb5d1d5462bab50f562807a834e6afe62cc55f49979742ed5707713f7708f70f46861f617e8489eea594037d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/75bb7565bb8dbb9f57382169ee67d57ceb82707c3aa4cb7775ab673ae4450168bcc1ae694e6afd202969b954d6c6ad345830a06f933cf8c4269839fa407ec32e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/436542b665de842a563c280766befc604bc2b9e348b49ef8c9653b92c724504e6df90fc62f752ee019641b6cff68a12380e852c50964de330a8cf25ea68f46e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c30d71d3287a5c6e50ab1a681c0f9403119f3bb91830d5a430be6fda386992c47e353308c8f538e9dee327e5e8fb2e7cbaee12189b31e22cd133b0f376495cd"} 14:48:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:01 INFO - Contents: 14:48:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9de2487bb24e373756d5571c6ebf9928e99b11e0eb5d1d5462bab50f562807a834e6afe62cc55f49979742ed5707713f7708f70f46861f617e8489eea594037d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/75bb7565bb8dbb9f57382169ee67d57ceb82707c3aa4cb7775ab673ae4450168bcc1ae694e6afd202969b954d6c6ad345830a06f933cf8c4269839fa407ec32e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/436542b665de842a563c280766befc604bc2b9e348b49ef8c9653b92c724504e6df90fc62f752ee019641b6cff68a12380e852c50964de330a8cf25ea68f46e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c30d71d3287a5c6e50ab1a681c0f9403119f3bb91830d5a430be6fda386992c47e353308c8f538e9dee327e5e8fb2e7cbaee12189b31e22cd133b0f376495cd"} 14:48:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:01 INFO - Copying logs to upload dir... 14:48:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.622046 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-20 14:48:01.357501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-20 14:48:01.365449) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 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/9de2487bb24e373756d5571c6ebf9928e99b11e0eb5d1d5462bab50f562807a834e6afe62cc55f49979742ed5707713f7708f70f46861f617e8489eea594037d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/75bb7565bb8dbb9f57382169ee67d57ceb82707c3aa4cb7775ab673ae4450168bcc1ae694e6afd202969b954d6c6ad345830a06f933cf8c4269839fa407ec32e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/436542b665de842a563c280766befc604bc2b9e348b49ef8c9653b92c724504e6df90fc62f752ee019641b6cff68a12380e852c50964de330a8cf25ea68f46e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c30d71d3287a5c6e50ab1a681c0f9403119f3bb91830d5a430be6fda386992c47e353308c8f538e9dee327e5e8fb2e7cbaee12189b31e22cd133b0f376495cd"} build_url:https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/HsarckXVTAuSLDR_pQTjLQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9de2487bb24e373756d5571c6ebf9928e99b11e0eb5d1d5462bab50f562807a834e6afe62cc55f49979742ed5707713f7708f70f46861f617e8489eea594037d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/75bb7565bb8dbb9f57382169ee67d57ceb82707c3aa4cb7775ab673ae4450168bcc1ae694e6afd202969b954d6c6ad345830a06f933cf8c4269839fa407ec32e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/436542b665de842a563c280766befc604bc2b9e348b49ef8c9653b92c724504e6df90fc62f752ee019641b6cff68a12380e852c50964de330a8cf25ea68f46e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6c30d71d3287a5c6e50ab1a681c0f9403119f3bb91830d5a430be6fda386992c47e353308c8f538e9dee327e5e8fb2e7cbaee12189b31e22cd133b0f376495cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-20 14:48:01.397443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:48:01.397757) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1508534671.894944-1049389922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-20 14:48:01.447119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-20 14:48:01.447482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-20 14:48:01.447782) ========= ========= Total master_lag: 0.18 =========