builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1506068741.41 results: success (0) revision: d9d005572999dd76652d5d8d40a87cc78b0b4866 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.409233) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.409642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.409921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.425988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.426282) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 01:25:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-09-22 01:25:41 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.523659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.524992) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014078 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.574496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:41.577828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d9d005572999dd76652d5d8d40a87cc78b0b4866 --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 d9d005572999dd76652d5d8d40a87cc78b0b4866 --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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 01:25:41,499 truncating revision to first 12 chars 2017-09-22 01:25:41,499 Setting DEBUG logging. 2017-09-22 01:25:41,499 attempt 1/10 2017-09-22 01:25:41,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d9d005572999?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 01:25:41,867 unpacking tar archive at: mozilla-beta-d9d005572999/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:42.245017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:42.245329) ========= script_repo_revision: d9d005572999dd76652d5d8d40a87cc78b0b4866 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:42.245703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:42.245975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 01:25:42.259390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-22 01:25:42.259749) ========= /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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:42 INFO - MultiFileLogger online at 20170922 01:25:42 in /builds/slave/test 01:25:42 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 01:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:42 INFO - {'append_to_log': False, 01:25:42 INFO - 'base_work_dir': '/builds/slave/test', 01:25:42 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 01:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:42 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 01:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:42 INFO - 'code_coverage': False, 01:25:42 INFO - 'config_files': ('talos/linux_config.py',), 01:25:42 INFO - 'default_actions': ('clobber', 01:25:42 INFO - 'read-buildbot-config', 01:25:42 INFO - 'download-and-extract', 01:25:42 INFO - 'populate-webroot', 01:25:42 INFO - 'create-virtualenv', 01:25:42 INFO - 'install', 01:25:42 INFO - 'setup-mitmproxy', 01:25:42 INFO - 'run-tests'), 01:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:42 INFO - 'disable_ccov_upload': False, 01:25:42 INFO - 'disable_stylo': False, 01:25:42 INFO - 'download_minidump_stackwalk': True, 01:25:42 INFO - 'download_symbols': 'ondemand', 01:25:42 INFO - 'enable_stylo': False, 01:25:42 INFO - 'enable_webrender': False, 01:25:42 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 01:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:42 INFO - 'gecko_profile': False, 01:25:42 INFO - 'gecko_profile_interval': 0, 01:25:42 INFO - 'installer_path': 'installer.exe', 01:25:42 INFO - 'log_level': 'info', 01:25:42 INFO - 'log_name': 'talos', 01:25:42 INFO - 'log_to_console': True, 01:25:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:42 INFO - 'opt_config_files': (), 01:25:42 INFO - 'pip_index': False, 01:25:42 INFO - 'suite': 'dromaeojs-e10s', 01:25:42 INFO - 'system_bits': '32', 01:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:42 INFO - 'title': 'talos-linux64-ix-073', 01:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:42 INFO - 'use_talos_json': True, 01:25:42 INFO - 'verify': 'False', 01:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:42 INFO - 'work_dir': 'build'} 01:25:42 INFO - [mozharness: 2017-09-22 08:25:42.322766Z] Running clobber step. 01:25:42 INFO - Running pre-action listener: _resource_record_pre_action 01:25:42 INFO - Running main action method: clobber 01:25:42 INFO - rmtree: /builds/slave/test/build 01:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:43 INFO - Running post-action listener: _resource_record_post_action 01:25:43 INFO - [mozharness: 2017-09-22 08:25:43.880498Z] Finished clobber step (success) 01:25:43 INFO - [mozharness: 2017-09-22 08:25:43.880596Z] Running read-buildbot-config step. 01:25:43 INFO - Running pre-action listener: _resource_record_pre_action 01:25:43 INFO - Running main action method: read_buildbot_config 01:25:43 INFO - Using buildbot properties: 01:25:43 INFO - { 01:25:43 INFO - "project": "", 01:25:43 INFO - "product": "firefox", 01:25:43 INFO - "who": "jlorenzo@mozilla.com", 01:25:43 INFO - "installer_path": "public/build/target.tar.bz2", 01:25:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 01:25:43 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 01:25:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 01:25:43 INFO - "stage_platform": "linux64", 01:25:43 INFO - "basedir": "/builds/slave/test", 01:25:43 INFO - "buildnumber": 104, 01:25:43 INFO - "platform": "ubuntu64_hw", 01:25:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:25:43 INFO - "slavebuilddir": "test", 01:25:43 INFO - "taskId": "BM-L05q2SqWNgAm78HfH6w", 01:25:43 INFO - "branch": "mozilla-beta", 01:25:43 INFO - "script_repo_revision": "production", 01:25:43 INFO - "revision": "d9d005572999dd76652d5d8d40a87cc78b0b4866", 01:25:43 INFO - "slavename": "talos-linux64-ix-073", 01:25:43 INFO - "repo_path": "releases/mozilla-beta" 01:25:43 INFO - } 01:25:43 INFO - Finding installer, test and symbols from parent task. 01:25:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BM-L05q2SqWNgAm78HfH6w'}, attempt #1 01:25:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BM-L05q2SqWNgAm78HfH6w'}, attempt #1 01:25:44 INFO - Task dependencies: FJg4EpomScKAf7QIMHp2Bg 01:25:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg'}, attempt #1 01:25:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 01:25:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.test_packages.json 01:25:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.crashreporter-symbols.zip 01:25:45 INFO - Running post-action listener: _resource_record_post_action 01:25:45 INFO - [mozharness: 2017-09-22 08:25:45.202039Z] Finished read-buildbot-config step (success) 01:25:45 INFO - [mozharness: 2017-09-22 08:25:45.202258Z] Running download-and-extract step. 01:25:45 INFO - Running pre-action listener: _resource_record_pre_action 01:25:45 INFO - Running main action method: download_and_extract 01:25:45 INFO - mkdir: /builds/slave/test/build/tests 01:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:45 INFO - trying https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.test_packages.json 01:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:25:45 INFO - Downloaded 989 bytes. 01:25:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:25:45 INFO - Using the following test package requirements: 01:25:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:25:45 INFO - u'common': [u'target.common.tests.zip'], 01:25:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:25:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:25:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:25:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:25:45 INFO - u'mozbase': [u'target.common.tests.zip'], 01:25:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:25:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:25:45 INFO - u'web-platform': [u'target.common.tests.zip', 01:25:45 INFO - u'target.web-platform.tests.tar.gz'], 01:25:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:25:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 01:25:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.common.tests.zip 01:25:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:25:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.common.tests.zip into memory 01:25:49 INFO - Content-Length response header: 55176682 01:25:49 INFO - Bytes received: 55176682 01:26:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.talos.tests.zip 01:26:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:26:00 INFO - Fetch https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.talos.tests.zip into memory 01:26:01 INFO - Content-Length response header: 14509184 01:26:01 INFO - Bytes received: 14509184 01:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:02 INFO - trying https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 01:26:02 INFO - Downloading https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:26:05 INFO - Downloaded 53455165 bytes. 01:26:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 01:26:05 INFO - mkdir: /builds/slave/test/properties 01:26:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:05 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:05 INFO - Contents: 01:26:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 01:26:05 INFO - Running post-action listener: _resource_record_post_action 01:26:05 INFO - Running post-action listener: find_tests_for_verification 01:26:05 INFO - Running post-action listener: set_extra_try_arguments 01:26:05 INFO - [mozharness: 2017-09-22 08:26:05.576147Z] Finished download-and-extract step (success) 01:26:05 INFO - [mozharness: 2017-09-22 08:26:05.576374Z] Running populate-webroot step. 01:26:05 INFO - Running pre-action listener: _resource_record_pre_action 01:26:05 INFO - Running main action method: populate_webroot 01:26:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:26:05 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['tresize', 01:26:05 INFO - 'tcanvasmark']}, 01:26:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:26:05 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['dromaeo_css', 01:26:05 INFO - 'kraken']}, 01:26:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:05 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'tests': ['damp', 'tps']}, 01:26:05 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['damp', 'tps']}, 01:26:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:05 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['dromaeo_dom']}, 01:26:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:26:05 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['basic_compositor_video', 01:26:05 INFO - 'glvideo']}, 01:26:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:26:05 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['ts_paint_webext', 01:26:05 INFO - 'tp5o_webext']}, 01:26:05 INFO - 'other-e10s': {'tests': ['a11yr', 01:26:05 INFO - 'ts_paint', 01:26:05 INFO - 'tpaint', 01:26:05 INFO - 'sessionrestore', 01:26:05 INFO - 'sessionrestore_many_windows', 01:26:05 INFO - 'sessionrestore_no_auto_restore', 01:26:05 INFO - 'tabpaint']}, 01:26:05 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['a11yr', 01:26:05 INFO - 'ts_paint', 01:26:05 INFO - 'tpaint', 01:26:05 INFO - 'sessionrestore', 01:26:05 INFO - 'sessionrestore_many_windows', 01:26:05 INFO - 'sessionrestore_no_auto_restore', 01:26:05 INFO - 'tabpaint']}, 01:26:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:26:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 01:26:05 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['perf_reftest_singletons']}, 01:26:05 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['bloom_basic']}, 01:26:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:26:05 INFO - 'tsvgr_opacity', 01:26:05 INFO - 'tart', 01:26:05 INFO - 'tscrollx', 01:26:05 INFO - 'tsvg_static']}, 01:26:05 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['tsvgx', 01:26:05 INFO - 'tsvgr_opacity', 01:26:05 INFO - 'tart', 01:26:05 INFO - 'tscrollx', 01:26:05 INFO - 'tsvg_static']}, 01:26:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:26:05 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo'], 01:26:05 INFO - 'tests': ['tp5o']}, 01:26:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:26:05 INFO - 'talos_options': ['--mitmproxy', 01:26:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:26:05 INFO - '--firstNonBlankPaint'], 01:26:05 INFO - 'tests': ['tp6_google', 01:26:05 INFO - 'tp6_youtube', 01:26:05 INFO - 'tp6_amazon', 01:26:05 INFO - 'tp6_facebook']}, 01:26:05 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo', 01:26:05 INFO - '--mitmproxy', 01:26:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:26:05 INFO - '--firstNonBlankPaint'], 01:26:05 INFO - 'tests': ['tp6_google', 01:26:05 INFO - 'tp6_youtube', 01:26:05 INFO - 'tp6_amazon', 01:26:05 INFO - 'tp6_facebook']}, 01:26:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:26:05 INFO - 'talos_options': ['--stylo-threads=1', 01:26:05 INFO - '--mitmproxy', 01:26:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:26:05 INFO - '--firstNonBlankPaint'], 01:26:05 INFO - 'tests': ['tp6_google', 01:26:05 INFO - 'tp6_youtube', 01:26:05 INFO - 'tp6_amazon', 01:26:05 INFO - 'tp6_facebook']}, 01:26:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--xperf_path', 01:26:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:05 INFO - 'tests': ['tp5n']}, 01:26:05 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:26:05 INFO - 'talos_options': ['--disable-stylo', 01:26:05 INFO - '--xperf_path', 01:26:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:05 INFO - 'tests': ['tp5n']}}} 01:26:05 INFO - Running post-action listener: _resource_record_post_action 01:26:05 INFO - [mozharness: 2017-09-22 08:26:05.596396Z] Finished populate-webroot step (success) 01:26:05 INFO - [mozharness: 2017-09-22 08:26:05.596485Z] Running create-virtualenv step. 01:26:05 INFO - Running pre-action listener: _resource_record_pre_action 01:26:05 INFO - Running main action method: create_virtualenv 01:26:05 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:26:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 01:26:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:26:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:06 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:06 INFO - Installing pip...............done. 01:26:06 INFO - Return code: 0 01:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:26:06 INFO - Reading from file tmpfile_stdout 01:26:06 INFO - Output received: 01:26:06 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 01:26:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:26:06 INFO - Using env: {'DISPLAY': ':0', 01:26:06 INFO - 'HOME': '/home/cltbld', 01:26:06 INFO - 'LANG': 'en_US.UTF-8', 01:26:06 INFO - 'LANGUAGE': 'en_US:en', 01:26:06 INFO - 'LOGNAME': 'cltbld', 01:26:06 INFO - 'MAIL': '/var/mail/cltbld', 01:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:06 INFO - 'MOZ_NO_REMOTE': '1', 01:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:06 INFO - 'NO_EM_RESTART': '1', 01:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:06 INFO - 'PWD': '/builds/slave/test', 01:26:06 INFO - 'SHELL': '/bin/bash', 01:26:06 INFO - 'SHLVL': '1', 01:26:06 INFO - 'TERM': 'linux', 01:26:06 INFO - 'TMOUT': '86400', 01:26:06 INFO - 'USER': 'cltbld', 01:26:06 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:06 INFO - '_': '/tools/buildbot/bin/python'} 01:26:08 INFO - Ignoring indexes: http://pypi.python.org/simple/ 01:26:08 INFO - Downloading/unpacking pip>=1.5 01:26:08 INFO - Running setup.py egg_info for package pip 01:26:08 INFO - warning: no files found matching 'pip/cacert.pem' 01:26:08 INFO - warning: no files found matching '*.html' under directory 'docs' 01:26:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:26:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:26:08 INFO - Installing collected packages: pip 01:26:08 INFO - Found existing installation: pip 1.1 01:26:08 INFO - Uninstalling pip: 01:26:08 INFO - Successfully uninstalled pip 01:26:08 INFO - Running setup.py install for pip 01:26:08 INFO - warning: no files found matching 'pip/cacert.pem' 01:26:08 INFO - warning: no files found matching '*.html' under directory 'docs' 01:26:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:26:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:26:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin 01:26:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 01:26:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 01:26:08 INFO - Successfully installed pip 01:26:08 INFO - Cleaning up... 01:26:08 INFO - Return code: 0 01:26:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:26:08 INFO - Using env: {'DISPLAY': ':0', 01:26:08 INFO - 'HOME': '/home/cltbld', 01:26:08 INFO - 'LANG': 'en_US.UTF-8', 01:26:08 INFO - 'LANGUAGE': 'en_US:en', 01:26:08 INFO - 'LOGNAME': 'cltbld', 01:26:08 INFO - 'MAIL': '/var/mail/cltbld', 01:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:08 INFO - 'MOZ_NO_REMOTE': '1', 01:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:08 INFO - 'NO_EM_RESTART': '1', 01:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:08 INFO - 'PWD': '/builds/slave/test', 01:26:08 INFO - 'SHELL': '/bin/bash', 01:26:08 INFO - 'SHLVL': '1', 01:26:08 INFO - 'TERM': 'linux', 01:26:08 INFO - 'TMOUT': '86400', 01:26:08 INFO - 'USER': 'cltbld', 01:26:08 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:08 INFO - '_': '/tools/buildbot/bin/python'} 01:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:08 INFO - Downloading/unpacking psutil>=3.1.1 01:26: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 01:26: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 01:26: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 01:26: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 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:09 INFO - Installing collected packages: psutil 01:26:09 INFO - Running setup.py install for psutil 01:26:09 INFO - building 'psutil._psutil_linux' extension 01:26:09 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 01:26:09 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 01:26:09 INFO - building 'psutil._psutil_posix' extension 01:26:09 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 01:26:10 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 01:26:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:10 INFO - Successfully installed psutil 01:26:10 INFO - Cleaning up... 01:26:10 INFO - Return code: 0 01:26:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:26:10 INFO - Using env: {'DISPLAY': ':0', 01:26:10 INFO - 'HOME': '/home/cltbld', 01:26:10 INFO - 'LANG': 'en_US.UTF-8', 01:26:10 INFO - 'LANGUAGE': 'en_US:en', 01:26:10 INFO - 'LOGNAME': 'cltbld', 01:26:10 INFO - 'MAIL': '/var/mail/cltbld', 01:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:10 INFO - 'MOZ_NO_REMOTE': '1', 01:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:10 INFO - 'NO_EM_RESTART': '1', 01:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:10 INFO - 'PWD': '/builds/slave/test', 01:26:10 INFO - 'SHELL': '/bin/bash', 01:26:10 INFO - 'SHLVL': '1', 01:26:10 INFO - 'TERM': 'linux', 01:26:10 INFO - 'TMOUT': '86400', 01:26:10 INFO - 'USER': 'cltbld', 01:26:10 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:10 INFO - '_': '/tools/buildbot/bin/python'} 01:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26: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 01:26: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 01:26: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 01:26: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 01:26:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:11 INFO - Installing collected packages: mozsystemmonitor 01:26:11 INFO - Running setup.py install for mozsystemmonitor 01:26:11 INFO - Successfully installed mozsystemmonitor 01:26:11 INFO - Cleaning up... 01:26:11 INFO - Return code: 0 01:26:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:26:11 INFO - Using env: {'DISPLAY': ':0', 01:26:11 INFO - 'HOME': '/home/cltbld', 01:26:11 INFO - 'LANG': 'en_US.UTF-8', 01:26:11 INFO - 'LANGUAGE': 'en_US:en', 01:26:11 INFO - 'LOGNAME': 'cltbld', 01:26:11 INFO - 'MAIL': '/var/mail/cltbld', 01:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:11 INFO - 'MOZ_NO_REMOTE': '1', 01:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:11 INFO - 'NO_EM_RESTART': '1', 01:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:11 INFO - 'PWD': '/builds/slave/test', 01:26:11 INFO - 'SHELL': '/bin/bash', 01:26:11 INFO - 'SHLVL': '1', 01:26:11 INFO - 'TERM': 'linux', 01:26:11 INFO - 'TMOUT': '86400', 01:26:11 INFO - 'USER': 'cltbld', 01:26:11 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:11 INFO - '_': '/tools/buildbot/bin/python'} 01:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:11 INFO - Downloading/unpacking jsonschema==2.5.1 01:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:13 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:13 INFO - warning: no files found matching '*.txt' 01:26:13 INFO - no previously-included directories found matching 'build' 01:26:13 INFO - no previously-included directories found matching 'dist' 01:26:13 INFO - no previously-included directories found matching '.git*' 01:26:13 INFO - Installing collected packages: jsonschema, functools32 01:26:13 INFO - Running setup.py install for functools32 01:26:13 INFO - warning: no files found matching '*.txt' 01:26:13 INFO - no previously-included directories found matching 'build' 01:26:13 INFO - no previously-included directories found matching 'dist' 01:26:13 INFO - no previously-included directories found matching '.git*' 01:26:13 INFO - Successfully installed jsonschema functools32 01:26:13 INFO - Cleaning up... 01:26:13 INFO - Return code: 0 01:26:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:26:13 INFO - Using env: {'DISPLAY': ':0', 01:26:13 INFO - 'HOME': '/home/cltbld', 01:26:13 INFO - 'LANG': 'en_US.UTF-8', 01:26:13 INFO - 'LANGUAGE': 'en_US:en', 01:26:13 INFO - 'LOGNAME': 'cltbld', 01:26:13 INFO - 'MAIL': '/var/mail/cltbld', 01:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:13 INFO - 'MOZ_NO_REMOTE': '1', 01:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:13 INFO - 'NO_EM_RESTART': '1', 01:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:13 INFO - 'PWD': '/builds/slave/test', 01:26:13 INFO - 'SHELL': '/bin/bash', 01:26:13 INFO - 'SHLVL': '1', 01:26:13 INFO - 'TERM': 'linux', 01:26:13 INFO - 'TMOUT': '86400', 01:26:13 INFO - 'USER': 'cltbld', 01:26:13 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:13 INFO - '_': '/tools/buildbot/bin/python'} 01:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:26:13 INFO - Cleaning up... 01:26:13 INFO - Return code: 0 01:26:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26: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')]} 01:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:26:13 INFO - Using env: {'DISPLAY': ':0', 01:26:13 INFO - 'HOME': '/home/cltbld', 01:26:13 INFO - 'LANG': 'en_US.UTF-8', 01:26:13 INFO - 'LANGUAGE': 'en_US:en', 01:26:13 INFO - 'LOGNAME': 'cltbld', 01:26:13 INFO - 'MAIL': '/var/mail/cltbld', 01:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:13 INFO - 'MOZ_NO_REMOTE': '1', 01:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:13 INFO - 'NO_EM_RESTART': '1', 01:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:13 INFO - 'PWD': '/builds/slave/test', 01:26:13 INFO - 'SHELL': '/bin/bash', 01:26:13 INFO - 'SHLVL': '1', 01:26:13 INFO - 'TERM': 'linux', 01:26:13 INFO - 'TMOUT': '86400', 01:26:13 INFO - 'USER': 'cltbld', 01:26:13 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:13 INFO - '_': '/tools/buildbot/bin/python'} 01:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:13 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:14 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:15 INFO - Downloading docopt-0.6.1.tar.gz 01:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:15 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:15 INFO - Running setup.py install for blobuploader 01:26:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:15 INFO - Running setup.py install for requests 01:26:15 INFO - Running setup.py install for docopt 01:26:16 INFO - Successfully installed blobuploader requests docopt 01:26:16 INFO - Cleaning up... 01:26:16 INFO - Return code: 0 01:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:26:16 INFO - Using env: {'DISPLAY': ':0', 01:26:16 INFO - 'HOME': '/home/cltbld', 01:26:16 INFO - 'LANG': 'en_US.UTF-8', 01:26:16 INFO - 'LANGUAGE': 'en_US:en', 01:26:16 INFO - 'LOGNAME': 'cltbld', 01:26:16 INFO - 'MAIL': '/var/mail/cltbld', 01:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:16 INFO - 'MOZ_NO_REMOTE': '1', 01:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:16 INFO - 'NO_EM_RESTART': '1', 01:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:16 INFO - 'PWD': '/builds/slave/test', 01:26:16 INFO - 'SHELL': '/bin/bash', 01:26:16 INFO - 'SHLVL': '1', 01:26:16 INFO - 'TERM': 'linux', 01:26:16 INFO - 'TMOUT': '86400', 01:26:16 INFO - 'USER': 'cltbld', 01:26:16 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:16 INFO - '_': '/tools/buildbot/bin/python'} 01:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 INFO - Running setup.py (path:/tmp/pip-PHRq1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 INFO - Running setup.py (path:/tmp/pip-36PZ0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 INFO - Running setup.py (path:/tmp/pip-8D74PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 INFO - Running setup.py (path:/tmp/pip-OucVE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Running setup.py (path:/tmp/pip-H5w1k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Running setup.py (path:/tmp/pip-afaUeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 INFO - Running setup.py (path:/tmp/pip-LCqBni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 INFO - Running setup.py (path:/tmp/pip-NVt5fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:16 INFO - Running setup.py (path:/tmp/pip-4oRJ1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:16 INFO - Running setup.py (path:/tmp/pip-Bumtop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 INFO - Running setup.py (path:/tmp/pip-0iFNev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 INFO - Running setup.py (path:/tmp/pip-Sv2ujT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 INFO - Running setup.py (path:/tmp/pip-xAnGPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 INFO - Running setup.py (path:/tmp/pip-sQUQbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 INFO - Running setup.py (path:/tmp/pip-k8i7JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:17 INFO - Running setup.py (path:/tmp/pip-O_ahtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:17 INFO - Running setup.py (path:/tmp/pip-uAOWAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:17 INFO - Running setup.py install for manifestparser 01:26:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:17 INFO - Running setup.py install for mozcrash 01:26:17 INFO - Running setup.py install for mozdebug 01:26:17 INFO - Running setup.py install for mozdevice 01:26:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:17 INFO - Running setup.py install for mozfile 01:26:18 INFO - Running setup.py install for mozhttpd 01:26:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozinfo 01:26:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozInstall 01:26:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozleak 01:26:18 INFO - Running setup.py install for mozlog 01:26:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for moznetwork 01:26:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozprocess 01:26:18 INFO - Running setup.py install for mozprofile 01:26:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozrunner 01:26:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:18 INFO - Running setup.py install for mozscreenshot 01:26:19 INFO - Running setup.py install for moztest 01:26:19 INFO - Running setup.py install for mozversion 01:26:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:26:19 INFO - Using env: {'DISPLAY': ':0', 01:26:19 INFO - 'HOME': '/home/cltbld', 01:26:19 INFO - 'LANG': 'en_US.UTF-8', 01:26:19 INFO - 'LANGUAGE': 'en_US:en', 01:26:19 INFO - 'LOGNAME': 'cltbld', 01:26:19 INFO - 'MAIL': '/var/mail/cltbld', 01:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:19 INFO - 'MOZ_NO_REMOTE': '1', 01:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:19 INFO - 'NO_EM_RESTART': '1', 01:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:19 INFO - 'PWD': '/builds/slave/test', 01:26:19 INFO - 'SHELL': '/bin/bash', 01:26:19 INFO - 'SHLVL': '1', 01:26:19 INFO - 'TERM': 'linux', 01:26:19 INFO - 'TMOUT': '86400', 01:26:19 INFO - 'USER': 'cltbld', 01:26:19 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:19 INFO - '_': '/tools/buildbot/bin/python'} 01:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:19 INFO - Running setup.py (path:/tmp/pip-MTie_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:19 INFO - Running setup.py (path:/tmp/pip-_JbfPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:19 INFO - Running setup.py (path:/tmp/pip-crNPFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:19 INFO - Running setup.py (path:/tmp/pip-sTwaQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:19 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)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:19 INFO - Running setup.py (path:/tmp/pip-TV_bYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:19 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)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:19 INFO - Running setup.py (path:/tmp/pip-G7H0_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:19 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)) 01:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:19 INFO - Running setup.py (path:/tmp/pip-h1GMri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:20 INFO - Running setup.py (path:/tmp/pip-fn7BAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:20 INFO - Running setup.py (path:/tmp/pip-AKffCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:20 INFO - Running setup.py (path:/tmp/pip-BwhaGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:20 INFO - Running setup.py (path:/tmp/pip-4EbxGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:20 INFO - Running setup.py (path:/tmp/pip-MUX69m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:20 INFO - Running setup.py (path:/tmp/pip-cXOSOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:20 INFO - Running setup.py (path:/tmp/pip-Iyz3fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:20 INFO - Running setup.py (path:/tmp/pip-PZ2vhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:20 INFO - Running setup.py (path:/tmp/pip-b0URqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:20 INFO - Running setup.py (path:/tmp/pip-HTDps7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:26:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:21 INFO - Downloading blessings-1.6.tar.gz 01:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:21 INFO - Installing collected packages: blessings 01:26:21 INFO - Running setup.py install for blessings 01:26:22 INFO - Successfully installed blessings 01:26:22 INFO - Cleaning up... 01:26:22 INFO - Return code: 0 01:26:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:22 INFO - Reading from file tmpfile_stdout 01:26:22 INFO - Current package versions: 01:26:22 INFO - argparse == 1.2.1 01:26:22 INFO - blessings == 1.6 01:26:22 INFO - blobuploader == 1.2.4 01:26:22 INFO - docopt == 0.6.1 01:26:22 INFO - functools32 == 3.2.3-2 01:26:22 INFO - jsonschema == 2.5.1 01:26:22 INFO - manifestparser == 1.1 01:26:22 INFO - mozInstall == 1.13 01:26:22 INFO - mozcrash == 1.0 01:26:22 INFO - mozdebug == 0.1 01:26:22 INFO - mozdevice == 0.51 01:26:22 INFO - mozfile == 1.2 01:26:22 INFO - mozhttpd == 0.7 01:26:22 INFO - mozinfo == 0.10 01:26:22 INFO - mozleak == 0.1 01:26:22 INFO - mozlog == 3.5 01:26:22 INFO - moznetwork == 0.27 01:26:22 INFO - mozprocess == 0.25 01:26:22 INFO - mozprofile == 0.28 01:26:22 INFO - mozrunner == 6.13 01:26:22 INFO - mozscreenshot == 0.1 01:26:22 INFO - mozsystemmonitor == 0.3 01:26:22 INFO - moztest == 0.8 01:26:22 INFO - mozversion == 1.4 01:26:22 INFO - psutil == 3.1.1 01:26:22 INFO - requests == 1.2.3 01:26:22 INFO - wsgiref == 0.1.2 01:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:26:22 INFO - Using env: {'DISPLAY': ':0', 01:26:22 INFO - 'HOME': '/home/cltbld', 01:26:22 INFO - 'LANG': 'en_US.UTF-8', 01:26:22 INFO - 'LANGUAGE': 'en_US:en', 01:26:22 INFO - 'LOGNAME': 'cltbld', 01:26:22 INFO - 'MAIL': '/var/mail/cltbld', 01:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:22 INFO - 'MOZ_NO_REMOTE': '1', 01:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:22 INFO - 'NO_EM_RESTART': '1', 01:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:22 INFO - 'PWD': '/builds/slave/test', 01:26:22 INFO - 'SHELL': '/bin/bash', 01:26:22 INFO - 'SHLVL': '1', 01:26:22 INFO - 'TERM': 'linux', 01:26:22 INFO - 'TMOUT': '86400', 01:26:22 INFO - 'USER': 'cltbld', 01:26:22 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:22 INFO - '_': '/tools/buildbot/bin/python'} 01:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:26:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:26:23 INFO - Installing collected packages: simplejson 01:26:23 INFO - Running setup.py install for simplejson 01:26:23 INFO - building 'simplejson._speedups' extension 01:26:23 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 01:26:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 01:26:24 INFO - Successfully installed simplejson 01:26:24 INFO - Cleaning up... 01:26:24 INFO - Return code: 0 01:26:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:24 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 0x15491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1711a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', '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 01:26:24 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 01:26:24 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 01:26:24 INFO - Using env: {'DISPLAY': ':0', 01:26:24 INFO - 'HOME': '/home/cltbld', 01:26:24 INFO - 'LANG': 'en_US.UTF-8', 01:26:24 INFO - 'LANGUAGE': 'en_US:en', 01:26:24 INFO - 'LOGNAME': 'cltbld', 01:26:24 INFO - 'MAIL': '/var/mail/cltbld', 01:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:24 INFO - 'MOZ_NO_REMOTE': '1', 01:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:24 INFO - 'NO_EM_RESTART': '1', 01:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:24 INFO - 'PWD': '/builds/slave/test', 01:26:24 INFO - 'SHELL': '/bin/bash', 01:26:24 INFO - 'SHLVL': '1', 01:26:24 INFO - 'TERM': 'linux', 01:26:24 INFO - 'TMOUT': '86400', 01:26:24 INFO - 'USER': 'cltbld', 01:26:24 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:24 INFO - '_': '/tools/buildbot/bin/python'} 01:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:26:24 INFO - Cleaning up... 01:26:24 INFO - Return code: 0 01:26:24 INFO - Running post-action listener: _resource_record_post_action 01:26:24 INFO - Running post-action listener: _start_resource_monitoring 01:26:24 INFO - Starting resource monitoring. 01:26:24 INFO - [mozharness: 2017-09-22 08:26:24.984080Z] Finished create-virtualenv step (success) 01:26:24 INFO - [mozharness: 2017-09-22 08:26:24.984552Z] Running install step. 01:26:24 INFO - Running pre-action listener: _resource_record_pre_action 01:26:24 INFO - Running main action method: install 01:26:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:25 INFO - Reading from file tmpfile_stdout 01:26:25 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:25 INFO - Reading from file tmpfile_stdout 01:26:25 INFO - Output received: 01:26:25 INFO - Usage: mozinstall [options] installer 01:26:25 INFO - Options: 01:26:25 INFO - -h, --help show this help message and exit 01:26:25 INFO - -d DEST, --destination=DEST 01:26:25 INFO - Directory to install application into. [default: 01:26:25 INFO - "/builds/slave/test"] 01:26:25 INFO - --app=APP Application being installed. [default: firefox] 01:26:25 INFO - mkdir: /builds/slave/test/build/application 01:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:26:39 INFO - Reading from file tmpfile_stdout 01:26:39 INFO - Output received: 01:26:39 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:39 INFO - Running post-action listener: _resource_record_post_action 01:26:39 INFO - [mozharness: 2017-09-22 08:26:39.885262Z] Finished install step (success) 01:26:39 INFO - [mozharness: 2017-09-22 08:26:39.885516Z] Running setup-mitmproxy step. 01:26:39 INFO - Running pre-action listener: _resource_record_pre_action 01:26:39 INFO - Running main action method: setup_mitmproxy 01:26:39 INFO - Skipping: mitmproxy is not required 01:26:39 INFO - Running post-action listener: _resource_record_post_action 01:26:39 INFO - [mozharness: 2017-09-22 08:26:39.886633Z] Finished setup-mitmproxy step (success) 01:26:39 INFO - [mozharness: 2017-09-22 08:26:39.886852Z] Running run-tests step. 01:26:39 INFO - Running pre-action listener: _resource_record_pre_action 01:26:39 INFO - Running pre-action listener: _set_gcov_prefix 01:26:39 INFO - Running main action method: run_tests 01:26:39 WARNING - Try message not found. 01:26:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:39 INFO - Python 2.7.3 01:26:39 INFO - Return code: 0 01:26:39 INFO - grabbing minidump binary from tooltool 01:26:39 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')]} 01:26:39 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 0x18b8090>, '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 0x18b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:39 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 01:26:39 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 01:26:39 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 01:26:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:40 INFO - Return code: 0 01:26:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:40 INFO - ENV: RUST_BACKTRACE is now full 01:26:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 01:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 01:26:40 INFO - Using env: {'DISPLAY': ':0', 01:26:40 INFO - 'HOME': '/home/cltbld', 01:26:40 INFO - 'LANG': 'en_US.UTF-8', 01:26:40 INFO - 'LANGUAGE': 'en_US:en', 01:26:40 INFO - 'LOGNAME': 'cltbld', 01:26:40 INFO - 'MAIL': '/var/mail/cltbld', 01:26:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:40 INFO - 'MOZ_NO_REMOTE': '1', 01:26:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:40 INFO - 'NO_EM_RESTART': '1', 01:26:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:40 INFO - 'PWD': '/builds/slave/test', 01:26:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:40 INFO - 'RUST_BACKTRACE': 'full', 01:26:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:26:40 INFO - 'SHELL': '/bin/bash', 01:26:40 INFO - 'SHLVL': '1', 01:26:40 INFO - 'TERM': 'linux', 01:26:40 INFO - 'TMOUT': '86400', 01:26:40 INFO - 'USER': 'cltbld', 01:26:40 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:40 INFO - '_': '/tools/buildbot/bin/python'} 01:26:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 01:26:40 INFO - mozversion application_buildid: 20170922070706 01:26:40 INFO - mozversion application_changeset: d9d005572999dd76652d5d8d40a87cc78b0b4866 01:26:40 INFO - mozversion application_display_name: Firefox 01:26:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:40 INFO - mozversion application_name: Firefox 01:26:40 INFO - mozversion application_remotingname: firefox 01:26:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:26:40 INFO - mozversion application_vendor: Mozilla 01:26:40 INFO - mozversion application_version: 57.0 01:26:40 INFO - mozversion platform_buildid: 20170922070706 01:26:40 INFO - mozversion platform_changeset: d9d005572999dd76652d5d8d40a87cc78b0b4866 01:26:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:26:40 INFO - mozversion platform_version: 57.0 01:26:40 INFO - using testdate: 1506068800 01:26:40 INFO - actual date: 1506068800 01:26:40 INFO - starting webserver on 'localhost:57767' 01:26:40 INFO - SUITE-START | Running 2 tests 01:26:40 INFO - TEST-START | dromaeo_css 01:26:40 INFO - Initialising browser for dromaeo_css test... 01:26:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57767/getInfo.html -profile /tmp/tmpsxU7gX/profile 01:26:40 INFO - TEST-INFO | started process 10937 (/builds/slave/test/build/application/firefox/firefox http://localhost:57767/getInfo.html) 01:26:45 INFO - TEST-INFO | 10937: exit 0 01:26:45 INFO - Browser initialized. 01:26:45 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:45 INFO - Using env: {'DISPLAY': ':0', 01:26:45 INFO - 'HOME': '/home/cltbld', 01:26:45 INFO - 'JSGC_DISABLE_POISONING': '1', 01:26:45 INFO - 'LANG': 'en_US.UTF-8', 01:26:45 INFO - 'LANGUAGE': 'en_US:en', 01:26:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:26:45 INFO - 'LOGNAME': 'cltbld', 01:26:45 INFO - 'MAIL': '/var/mail/cltbld', 01:26:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:45 INFO - 'MOZ_CRASHREPORTER': '1', 01:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:26:45 INFO - 'MOZ_NO_REMOTE': '1', 01:26:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:45 INFO - 'NO_EM_RESTART': '1', 01:26:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:45 INFO - 'PWD': '/builds/slave/test', 01:26:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:45 INFO - 'RUST_BACKTRACE': 'full', 01:26:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:26:45 INFO - 'SHELL': '/bin/bash', 01:26:45 INFO - 'SHLVL': '1', 01:26:45 INFO - 'TERM': 'linux', 01:26:45 INFO - 'TMOUT': '86400', 01:26:45 INFO - 'USER': 'cltbld', 01:26:45 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:45 INFO - '_': '/tools/buildbot/bin/python'} 01:26:45 INFO - TEST-INFO | started process 11126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsxU7gX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:56 INFO - PID 11126 | RSS: Main: 144220160 01:26:56 INFO - PID 11126 | 01:29:54 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57767/tests/dromaeo/cssquery-ext.html) 01:29:55 INFO - PID 11126 | RSS: Main: 147447808 01:29:55 INFO - PID 11126 | 01:32:56 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-ext.html (next: http://localhost:57767/tests/dromaeo/cssquery-jquery.html) 01:32:57 INFO - PID 11126 | RSS: Main: 145768448 01:32:57 INFO - PID 11126 | 01:35:59 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57767/tests/dromaeo/cssquery-mootools.html) 01:35:59 INFO - PID 11126 | RSS: Main: 147447808 01:35:59 INFO - PID 11126 | 01:39:01 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57767/tests/dromaeo/cssquery-prototype.html) 01:39:01 INFO - PID 11126 | RSS: Main: 147218432 01:39:01 INFO - PID 11126 | 01:42:04 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57767/tests/dromaeo/cssquery-yui.html) 01:42:05 INFO - PID 11126 | RSS: Main: 148852736 01:42:05 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | Cycle 1(1): loaded http://localhost:57767/tests/dromaeo/cssquery-yui.html (next: http://localhost:57767/tests/dromaeo/cssquery-dojo.html) 01:45:06 INFO - PID 11126 | RSS: Main: 151093248 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | __start_tp_report 01:45:06 INFO - PID 11126 | _x_x_mozilla_page_load 01:45:06 INFO - PID 11126 | _x_x_mozilla_page_load_details 01:45:06 INFO - PID 11126 | |i|pagename|runs| 01:45:06 INFO - PID 11126 | |0;dojo.html;3982.8805135845937;3990.740601860879;4004.919901601968;4054.5337286212093;4082.122343696107;6584.242812076613;6613.669316534172;6615.867682646344;6683.632400217986;6718.46252299816;6657.833554161149;6671.566348187364;6706.0276259942275;6707.664616769154;6762.62805545696;5971.134185543094;5985.4912332451795;6033.1855199548045;6061.515078793708;6085.695715214244;6021.909671354933;6036.034234522477;6038.69806509675;6042.57701960863;6105.20632317798;5980;5982.312034116088;6012.3687012863675;6015.09773533969;6103.115048317991;6053.394660533933;6056.818295451144;6110.633361998272;6123.816285511397;6131.846703832395;6021.608595441282;6050.667213303266;6068.423499767515;6112.51099912006;6130.080487926846;6490.513211509156;6584.9012264816065;6620.3710647488415;6688.565243259172;6691.665416729193;7196.46026548011;7239.746608868717;7248.420126389876;7259.818504537376;7277.781666550012;7222;7232.710691572331;7313.378362839112;7324.6337683115635;7324.780256592311;6729.798106056826;6753.628550429725;6806.18325800907;6814.557053791487;6816.4546836252985;7290.71928506467;7320.890186647204;7339.045924029842;7400.222976587488;7483.363914067257;7148.213696493382;7196.280371962762;7216.819579510449;7222.819429514304;7233;7241;7277.126744790659;7308.232635573295;7338.302861228175;7347.5224110432655;7124;7205.063341765537;7207.96396018027;7214.603196824225;7233.095863017123;7149.463790215755;7170.139583250043;7225.8554828903125;7234.204237533867;7237.782866514013;5330.92003619946;5352.678839269578;5352.678839269656;5418.322709661293;5421.1055175895535;4847.515248475124;4875.975620121948;4882.414110306715;4921.409430868319;4926.1379258629595;6595.241547222035;6661.533692641566;6667.299933507009;6704.2625311215725;6760.0535924970545;7144.071270734875;7208.675609597581;7225.494215404871;7231.16841563227;7233.421326293884;6610.206775187008;6616.900746488806;6696.7656132035145;6701.966490167518;6716.361945615159;6188.133661287423;6261.405166509175;6278.529110316745;6280.466160376419;6281.340459251713;7468.103827540621;7471.103467583925;7491.400687945061;7547.320741133324;7567.31894129531;7143.071400717873;7181.533200341961;7274.527155734861;7275.781726548;7327.560346379128;7386.956801393263;7498.512596681198;7508.0990281166605;7588.089429268523;7603.163651998165;7127.714891404493;7157.677904494414;7198.5320954137815;7237.855242895218;7256.7460138894885;7062.8940565890525;7258.528195667264;7286.234945330664;7368.926310736824;7376.668049937873;6896.241413444417;6944.131983502062;7033.402160816388;7033.824154396181;7094.822629434306;6988.37104660583;6994.545354551938;7041.6831242595235;7087.397571206299;7092.432605391453;6899.586024838526;6907.13660792401;6911.067005954132;6997.860042799014;7013;6879.105716256855;7048;7089.964550177217;7150.570965742072;7159.749408770668;6714.630695311805;6849.24658287598;6885.173779146334;6933.341332573397;6955.234924158237 01:45:06 INFO - PID 11126 | |1;ext.html;973.6202880876457;983.8524221366798;988.9505524723764;1035.818731721949;1036.8185567525682;43404.78297608515;45355.31967020493;45560.3165952511;45604.77197614012;45674;41902.371464428055;41948.37077443841;42108;42209.36685949713;42559.574404255945;8010.1589333120055;8113.553754543498;8119.634616442274;8121.4721043132;8128.105908350077;8076.273135417811;8112.797180070486;8136.3084137848355;8143.307818835406;8152.959235203815;8414.83170336593;8549.273311768507;8549.743507694748;8551.615177317035;8562.357823163256;8443.282321002722;8503.532305723184;8503.61733721984;8506.914930850706;8514.361422893307;8803.29573634114;8884.20042196199;8887.822243555158;8890.73327800167;8897.332700047458;40284.194316113804;40776.59223407758;40785.59214407847;40789.592104078874;40913.38629920524;3794.1083845296334;3830.042489377656;3833.271678381099;3842.1739326044753;3849.0377405648587;33201.6679833201;33497.497537536954;33560.83219583911;33696.32607347839;33752.32495350079;5636.718164091779;5641;5672.035753921843;5683.658980461186;5727.083666613322;221995;222528;222716;223103;223423;51215.23177152346;51419.742901286;51499.742501288005;51594.22608660873;51620.22569661458;54838.45161548333;55145.172822407694;55150.17274740882;55153.44846551483;55260;18259.087045647666;18609.162587683317;18614.627707445776;18715.625687486445;18758.437246882615;15338.693226135638;15398.07611543311;15418.229088545751;15436.768448473282;15450.381984720485;15284;15391.692166156614;15416.229188540752;15620.84379156194;15639.609009774618;6026.758929642765;6225.782097626561;6240.126382306481;6240.843978900564;6258.906116408258;1091.9344839309667;1111.9610813621484;1112.038087054692;1115.5314767797545;1116.1015382616908;25592;25668.229953101436;25919.481610367686;25939.610905836427;26054;1229.9938500307442;1232.6918270432393;1233.6545767185203;1240.3736113262926;1256.5162412471263;13626.795598066037;13694.52069177574;13739.793903091462;13848;14023.439062437592;288680;310821;312730;313266;316383;62302.68848655818;62586.374136258964;62616;63046.68476657679;63062.68468657719;1444.6740747396682;1446.4864972934456;1459.9489017884323;1472.9631759206106;1530.8163020437619;30035.249118772204;30422.239444014078;30557.388852223277;30643.54034689437;30996.450177491486;40917.79541102275;40960.79519602383;41089.38365924573;41112.79443602763;41134.794326029376;271221;271324;271514;272854;273653;37121.443178352885;37262.06844828901;37314.253714925006;37429.43855842219;37584.43623345707;43440.78279608582;45779;46076;46165;46180.769096154305;33935.3212935735;33962.66037339694;34170;34289.657103428646;34404.48393274153;34204;34305.82847085749;34458.655413445544;34751.65248347585;34968.475472867416;39048.82853514399;39946;39956.40065398963;40143.799281003405;40361.39457908193;32648.836755816068;33248.833755832035;33302.5004624926;33398.83300583579;33403.16492087717;25168;25221;25320.493590128463;25544.23367298984;25762 01:45:06 INFO - PID 11126 | |2;jquery.html;635.1647725654391;641.9149975574011;642.5655748911154;655.1394040923776;655.3708439897698;22553.210637627686;24210.757892421094;24752;24753.009879604793;24990.250292491208;26332.73667263327;26627.06805261816;26651.333716657093;26775;26819.195424137306;6529.640869752162;6868.484863635223;6886.690098945534;6990.720371185159;7128.251533588977;6814.114165158548;6911.170659520864;6926.445884329267;6929.133858267692;6941.132358455193;6601.5708978916455;6832.145981752281;6880.346367095118;6915.204751453597;6916.65416729164;6886.655667216644;6917.412019978283;6922.688479018431;6947.062146610194;6949.617771022592;6467.51493637979;6501.6749162542155;6506.186726659168;6526.836829079263;6530.673466326664;29153.41693166146;29946;30601.08196754101;30717.846410768027;30775.692243077505;2365.8698771567556;2415.927522174338;2418.22616762636;2423.6728041714496;2427.1990243219693;20374.694379584318;20672.379828605164;20792.896035519876;20808.16767329305;21020.789792102038;2546.579814330652;2608.334874606982;2642.696089949661;2648.9867550662316;2661.5874539446418;141829;144519.27740361335;146420.99999999892;154130.22934885253;161155.1942240293;16147;16483.6703265934;16900.492985210465;17157.656846863243;17619.823801762075;26864.32839178997;26877.462450751267;26884.193474195807;26899;26912.59631105535;11542.769144617061;11549.307041577533;11666.766664666658;11841.5855445059;11916.285022898654;10579.31234469757;10670.039696427204;10686.625968091079;10746;10839.349639021684;9768.169705574963;10039.297249192632;10307.896921030693;10321.84517232242;10335.793284134275;3069.0204817892336;3104.0842951329414;3114.8286844223785;3138.325260069096;3156.163616641592;1048.5163493656544;1056.6460235821087;1061.6708820265587;1065.387402243713;1070.0369667299492;20358.694619580718;20868;21306.78693213079;21520;21543.46141346479;1117.044926587772;1125.5329038448951;1127.8702949160952;1131.3438205840594;1137.4851708221636;11352.48913798881;11413;11711.472983715754;11745.412729363668;11786.705332366588;605014;615626;619744;625097;641415;122277;124209;124936.37531812282;125172.37413812873;129110.35444822715;1139.5072455083866;1181.1082632612495;1182.4619797991893;1259.9811002834965;1265.8544267409181;23076.4230894229;23589.646155307342;23608.29175124749;23734.762652373945;23937.640935385636;64582.35417645764;66407.33592664011;67164.32835671776;67974;68082;84931;85688.57155714181;86160.56919715612;86692;87359.1264087351;20463.79536204619;20898.37304880856;21186.682199767325;21276.255331063338;21277.46806329854;23252.3024309271;23558.293251202493;23652.408689782893;23797.167099151447;23833.88083059643;19451.51371215731;19597.70603440978;19599.510012249808;19761.802381975995;19853;16935;17190.484285471455;17242.741358879877;17296.308147673953;18375.908120459313;18622.81377186265;18648.906755466134;18703.158357873657;18884.716729248797;19592.510187245432;19257.903710481358;19446.8055319445;19495.415137545897;19591.216351345785;19696.90151549233;17565.648687026445;17686.380976665754;17702.203400846734;18358.908205459422;18550.257989680802 01:45:06 INFO - PID 11126 | |3;mootools.html;1416.2847761880248;1484.109534279433;1487.4645127754006;1495.7681559358296;1497.1765528959077;17321.82678173218;17940.282388704454;17981.100944952734;17994.65040121991;18007.81992180078;17327.22027508762;17443.651126977453;17473.825261747377;17485.562860928483;17486.47540573785;2895.1459319500796;2939.58845761593;2979.942120547207;2986.970130298691;2987.1337312179444;2857.6570811502647;2904.0271509044496;2907.331313797828;2913.562965555173;2926.239177813773;2842.715728427151;2846.2315174902765;2936.9265768355854;2944.175630823362;2949.6460424748952;2881.625388699466;2908.476474234637;2914.096630044682;2927.1072322941495;2941.558766185068;2777.916662500128;2813.22636275024;2843.175479111055;2850.144956513038;2860.0847728726817;16820.83179168205;16898.493045208663;16987;17018.404355847484;17021.23404446803;8218.096009438957;8536.78658033548;8541.487510749314;8545.529995850226;8554.35842311829;5561.721913904329;5726.169705392736;5783.62406443584;5800.535957123462;5893.734781934781;2142.924997625076;2208.9149746192907;2211.3034394165948;2243.32700189944;2249.5725812095648;31220.531692024637;31412.685873141432;31590.998855108726;31604.683953160406;31668.208294792585;6738.59568425896;6925;6955.234924158339;6980.930190698028;7098.822529436806;20319.18723251083;20394.592108157754;20501.38495845127;20512;20576.897115514326;8181.877271840927;8261.586920653943;8276.420650554524;8283.751487455385;8308.792280192923;7466.701331946661;7585.6965721370525;7628.580428076509;7662.5402475850515;7677.193894640982;5720.570957178228;5846.941530584725;5970.611910225908;6023.216981792339;6095.664738439428;1467.9926600367144;1543.2052492966131;1551.2631500037392;1578.8973716708376;1604.8314926932737;1016.2124353625999;1018.556927736437;1021.0453226233495;1023.1610079734546;1036.3212096077082;8805.559722014003;8977.371583989057;9015;9096.226820720312;9133.543322833832;1086.4079076903106;1089.2919602258596;1095.0965453500735;1096.1942971915635;1103.2828661370174;5409.0263752524925;5472.616916815864;5517.915276967595;5523.475269849358;5546.417626149277;26478.6028209577;27048.323791904968;27268.181954541396;27280.727192728216;27306.86346568294;25538.489230215662;25821.225363239133;26048.8697556511;26488.205353839414;26499.73500265011;12555.497780088694;12959.092863499653;13032.54386096501;13036.608901732963;13039.543615973585;9594.712158635251;9821;9896.455694936847;9904.158146557624;9968.651097211563;21739.891300543397;21779.564408712053;21850.781492184873;22268.331950041524;22394.104235830386;22933;23237.41906452352;23319.41701457477;23407.648885267074;23625.40936476602;12233.755324893631;12335.259884406963;12473.688157796129;12495.437705303464;12502.374881255719;15129;15343.923280383528;15357.232138392812;15360.23198840076;15381.461648842236;12520.248785072925;12521;12582.622521324009;12672.556460523838;12940.288284144463;12336.62990110298;12437.191582547106;12441.129120961446;12501.749965000467;12525.93737031309;10878.12974962017;11122.221444498808;11180.776384472103;11189.440527973731;11200.21598488098;8950.955245223733;8968.506732129796;9003.324750643858;9039.412438191497;9186.816263674555;8566.82866342682;8586;8600.483970961763;8708.129187081242;8767.693130740394 01:45:06 INFO - PID 11126 | |4;prototype.html;566.6965978250024;570.6690119730557;573.5039191099698;604.356360476093;607.6991889014938;6400.839979000527;6454.386833250839;6522.8043158705195;6550.508711846613;6576.342365763421;6392.6484043377595;6417.486601071914;6456.935430645693;6469.57947733397;6540.705668244928;5340.038793017256;5352.892942141155;5359.410464848864;5373.623846330758;5388.191771234327;5025.296458495814;5148.34075161979;5321.3348331458565;5350.121162157444;5399.595030372738;5116.411612664554;5138.02186158328;5153;5159.432462429129;5163.251328557357;5122.795088196468;5133.666311689728;5174.2238664200295;5184.5483264685945;5195.844124676266;4643.95356046442;4650.883727906796;4653.906921861544;4656.278276867091;4670.112678591091;6203.131561581382;6249.687515624246;6307.432331090224;6395.424411802914;6427.903581446282;5942.554308426842;6016.729247183844;6041.214642096544;6097.3292937776805;6112.266528016622;6818.2159051709195;6835.829104272433;6877.695971849436;6878.454971660468;6930.896036559456;5223.112070947948;5236.869078273074;5241.9213711794355;5261.263423120766;5276.3932147802725;6864.73463756959;7053.470989675743;7071.575705457689;7077.823054423629;7167.784966451015;5368.9731551342775;5389.299391079135;5389.784408623611;5423.2136340230445;5449.47414723878;5395.757190926418;5468.507834294853;5481.369642491165;5485.451454854562;5519.282493275929;6059.970119870237;6097.512199024068;6101.694915254219;6111.113888486234;6124;6921.307869213139;6922.307769223037;6937.063496428019;6988.650567471606;6993.545419547713;1850.1674246589089;1877.7465042219399;1886.858485613557;1892.1107079672531;1899.164367678217;1287.819705241267;1322.8280323558067;1343.7312537492542;1356.1727346318737;1357.6198664373992;6345.936540634627;6356.872862542816;6360.332165122688;6370.426661600478;6372.617642941438;6884.65576721162;6934.237233904368;6948.722051117898;6999.255398361852;7038.40173585251;6403.551751377452;6433.678316084177;6459.677016149174;6465.4827613790785;6503.219613646393;3655.2689462107683;3683.8710645127826;3690.7785532868115;3696.8336424860945;3708.332500149999;6971.825704357431;7019.5788252705;7020.964895175492;7160.785176444715;7260.165081015751;7025.683844227022;7049.612271325023;7081.433485321162;7124.46566507514;7202.243764404767;7240.782776516713;7253.891191632024;7264.34620884123;7301.671424785897;7309.4152467803515;6929.826754331182;6973.721051157897;6978.546394484342;6978.953157026486;7032.683529241299;6885.586864788129;6917.584944903322;6927.7228910843005;6952.061471701458;7019.543729657556;7086.574805511686;7198.604076775828;7225.6387180641805;7255.383292420203;7297.890531641923;5364.436734142859;5403.729813509387;5407.324084489439;5409.810656626999;5454.127339625641;6693.799186024427;6721.731130754715;6902.137232845895;6992.895106573304;6998.16022077354;6625.103657744708;6656.600603963778;6743.224529179207;6746.460283177236;6797.660116994031;6515;6598.406143447113;6626.204855417381;6693.665316734241;6696.5647232929705;6534.411902928569;6549.410553050057;6569.507286953593;6651.667416629246;6745.156855393076;6676.76479851229;6746.684396542627;6775.830604234933;6804;6822.624755638488;6539.247986481425;6599.274079851309;6618.338166183343;6639.767608133692;6674.16572928384 01:45:06 INFO - PID 11126 | |5;yui.html;983.8819341679;1016.060144366461;1018.2007124407342;1027.1577306608583;1040.3653771199567;20566.588668226646;20855.582888342262;20923.581528369425;20958.580828383463;21035.57928841422;19576;20045.298414555495;20427.285045023425;20554;20628.17487300506;1059.1579694143156;1068.2575609951086;1070.7804899995483;1071.0146665068137;1071.935683858971;1056.0812093478685;1065.8614380130573;1067.3809190669392;1073.8335557988523;1114.5653195253817;1183.9585614503494;1184.319016565474;1187.56653821355;1190.6309044196285;1191.696117490039;1163.7497937943383;1173.1729130962651;1176.3765204441659;1178.9528418863235;1179.4338717415646;857.3612658569343;858.5707146426787;861.6165806216236;862.529921192945;863.3007264116086;20838;21288;21334.573308533898;21440.571188576298;23093;23920.880395598084;23932.52134957291;24302.270931872074;24528.14151504689;24578.877105614538;19805.504862378413;19909.402717918485;20140.194392224294;20152.49618759528;20182.697259541117;3991.600839915985;4017.417474466186;4020.1155745736182;4050.9797451012555;4055.371417430303;163562;168027;169251.15374423173;170865;171508;17520.737188942177;17962.5509362267;18083;18100;18331.35840245585;34835.65164348375;34966.825165874514;35849.82075089608;35850.46224306637;35905.281894361964;9758.853617195748;9846.753831154278;9890.060444257928;9929.30494865367;9999.150072243796;4741.051789642085;4748.786304616231;4771.570558649669;4779.856604301876;4782.928256076161;5651.15232715096;5679.488846003796;5687.800926967537;5771.509421699118;5786.1610066540115;1149.9827502587468;1174.0724827386439;1178.7112157521462;1179.1981452612135;1190.6487586162102;751.9436042296741;770.7726220764888;781.6912319633713;789.7235967411475;797.9746026356105;12543.310117943418;13308.26804525741;14170.504032358818;14317;14554.345054472575;775.3022279948092;786.6420778545748;789.0886026639241;791.2325044706625;794.8251384695358;6270.561060725797;6341.587796793194;6354.3963323484195;6484.319146489645;6509.218893732783;158119.20940395223;158286;159513;159774;161716;131541;133051.33474332566;136444;139236;142018;114989;121026.39486802509;121072;123210;127782.36108819583;14190.929045354707;14558.781618275523;14638.194899280641;14706.41174353014;14706.63233419173;55236.72381638066;55342.72328638331;55824.72087639536;57111;57211;100378;100404;101769.49115254376;102225;103216.48391757993;21593.784062159804;22035.338939831832;22080.668789968484;22366.105355785585;22388.21641242549;24077.51844963056;24846.875765621055;25012.37469063288;25265.989360426112;25284;22590.435239118495;22952.885235573714;23207.651885222072;23463.648045279675;23510.764892350857;20690.17239310411;21303.25438609641;21328.680069799277;21560;22092.226772062902;22089.447763806034;22491.66262506031;22614.434639133495;22787.31638050861;22845.200417985292;12954.481820727065;13545.59363219105;13952.302384880919;13977.58067257984;14433.78349324782;15785.68428631444;16066.678666426373;16238.350465981228;16587.419440319532;16694.4156954506 01:45:06 INFO - PID 11126 | __end_tp_report 01:45:06 INFO - PID 11126 | __start_cc_report 01:45:06 INFO - PID 11126 | _x_x_mozilla_cycle_collect,256 01:45:06 INFO - PID 11126 | __end_cc_report 01:45:06 INFO - PID 11126 | __startTimestamp1506069906838__endTimestamp 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | ------- Summary: start ------- 01:45:06 INFO - PID 11126 | Number of tests: 6 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#0] dojo.html Cycles:165 Average:6683.82 Median:6911.07 stddev:774.26 (11.2%) stddev-sans-first:747.08 01:45:06 INFO - PID 11126 | Values: 3982.9 3990.7 4004.9 4054.5 4082.1 6584.2 6613.7 6615.9 6683.6 6718.5 6657.8 6671.6 6706.0 6707.7 6762.6 5971.1 5985.5 6033.2 6061.5 6085.7 6021.9 6036.0 6038.7 6042.6 6105.2 5980.0 5982.3 6012.4 6015.1 6103.1 6053.4 6056.8 6110.6 6123.8 6131.8 6021.6 6050.7 6068.4 6112.5 6130.1 6490.5 6584.9 6620.4 6688.6 6691.7 7196.5 7239.7 7248.4 7259.8 7277.8 7222.0 7232.7 7313.4 7324.6 7324.8 6729.8 6753.6 6806.2 6814.6 6816.5 7290.7 7320.9 7339.0 7400.2 7483.4 7148.2 7196.3 7216.8 7222.8 7233.0 7241.0 7277.1 7308.2 7338.3 7347.5 7124.0 7205.1 7208.0 7214.6 7233.1 7149.5 7170.1 7225.9 7234.2 7237.8 5330.9 5352.7 5352.7 5418.3 5421.1 4847.5 4876.0 4882.4 4921.4 4926.1 6595.2 6661.5 6667.3 6704.3 6760.1 7144.1 7208.7 7225.5 7231.2 7233.4 6610.2 6616.9 6696.8 6702.0 6716.4 6188.1 6261.4 6278.5 6280.5 6281.3 7468.1 7471.1 7491.4 7547.3 7567.3 7143.1 7181.5 7274.5 7275.8 7327.6 7387.0 7498.5 7508.1 7588.1 7603.2 7127.7 7157.7 7198.5 7237.9 7256.7 7062.9 7258.5 7286.2 7368.9 7376.7 6896.2 6944.1 7033.4 7033.8 7094.8 6988.4 6994.5 7041.7 7087.4 7092.4 6899.6 6907.1 6911.1 6997.9 7013.0 6879.1 7048.0 7090.0 7150.6 7159.7 6714.6 6849.2 6885.2 6933.3 6955.2 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#1] ext.html Cycles:180 Average:44650.59 Median:37506.94 stddev:70357.27 (187.6%) stddev-sans-first:70478.21 01:45:06 INFO - PID 11126 | Values: 973.6 983.9 989.0 1035.8 1036.8 43404.8 45355.3 45560.3 45604.8 45674.0 41902.4 41948.4 42108.0 42209.4 42559.6 8010.2 8113.6 8119.6 8121.5 8128.1 8076.3 8112.8 8136.3 8143.3 8153.0 8414.8 8549.3 8549.7 8551.6 8562.4 8443.3 8503.5 8503.6 8506.9 8514.4 8803.3 8884.2 8887.8 8890.7 8897.3 40284.2 40776.6 40785.6 40789.6 40913.4 3794.1 3830.0 3833.3 3842.2 3849.0 33201.7 33497.5 33560.8 33696.3 33752.3 5636.7 5641.0 5672.0 5683.7 5727.1 221995.0 222528.0 222716.0 223103.0 223423.0 51215.2 51419.7 51499.7 51594.2 51620.2 54838.5 55145.2 55150.2 55153.4 55260.0 18259.1 18609.2 18614.6 18715.6 18758.4 15338.7 15398.1 15418.2 15436.8 15450.4 15284.0 15391.7 15416.2 15620.8 15639.6 6026.8 6225.8 6240.1 6240.8 6258.9 1091.9 1112.0 1112.0 1115.5 1116.1 25592.0 25668.2 25919.5 25939.6 26054.0 1230.0 1232.7 1233.7 1240.4 1256.5 13626.8 13694.5 13739.8 13848.0 14023.4 288680.0 310821.0 312730.0 313266.0 316383.0 62302.7 62586.4 62616.0 63046.7 63062.7 1444.7 1446.5 1459.9 1473.0 1530.8 30035.2 30422.2 30557.4 30643.5 30996.5 40917.8 40960.8 41089.4 41112.8 41134.8 271221.0 271324.0 271514.0 272854.0 273653.0 37121.4 37262.1 37314.3 37429.4 37584.4 43440.8 45779.0 46076.0 46165.0 46180.8 33935.3 33962.7 34170.0 34289.7 34404.5 34204.0 34305.8 34458.7 34751.7 34968.5 39048.8 39946.0 39956.4 40143.8 40361.4 32648.8 33248.8 33302.5 33398.8 33403.2 25168.0 25221.0 25320.5 25544.2 25762.0 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#2] jquery.html Cycles:180 Average:40775.61 Median:23164.36 stddev:103641.18 (447.4%) stddev-sans-first:103888.10 01:45:06 INFO - PID 11126 | Values: 635.2 641.9 642.6 655.1 655.4 22553.2 24210.8 24752.0 24753.0 24990.3 26332.7 26627.1 26651.3 26775.0 26819.2 6529.6 6868.5 6886.7 6990.7 7128.3 6814.1 6911.2 6926.4 6929.1 6941.1 6601.6 6832.1 6880.3 6915.2 6916.7 6886.7 6917.4 6922.7 6947.1 6949.6 6467.5 6501.7 6506.2 6526.8 6530.7 29153.4 29946.0 30601.1 30717.8 30775.7 2365.9 2415.9 2418.2 2423.7 2427.2 20374.7 20672.4 20792.9 20808.2 21020.8 2546.6 2608.3 2642.7 2649.0 2661.6 141829.0 144519.3 146421.0 154130.2 161155.2 16147.0 16483.7 16900.5 17157.7 17619.8 26864.3 26877.5 26884.2 26899.0 26912.6 11542.8 11549.3 11666.8 11841.6 11916.3 10579.3 10670.0 10686.6 10746.0 10839.3 9768.2 10039.3 10307.9 10321.8 10335.8 3069.0 3104.1 3114.8 3138.3 3156.2 1048.5 1056.6 1061.7 1065.4 1070.0 20358.7 20868.0 21306.8 21520.0 21543.5 1117.0 1125.5 1127.9 1131.3 1137.5 11352.5 11413.0 11711.5 11745.4 11786.7 605014.0 615626.0 619744.0 625097.0 641415.0 122277.0 124209.0 124936.4 125172.4 129110.4 1139.5 1181.1 1182.5 1260.0 1265.9 23076.4 23589.6 23608.3 23734.8 23937.6 64582.4 66407.3 67164.3 67974.0 68082.0 84931.0 85688.6 86160.6 86692.0 87359.1 20463.8 20898.4 21186.7 21276.3 21277.5 23252.3 23558.3 23652.4 23797.2 23833.9 19451.5 19597.7 19599.5 19761.8 19853.0 16935.0 17190.5 17242.7 17296.3 18375.9 18622.8 18648.9 18703.2 18884.7 19592.5 19257.9 19446.8 19495.4 19591.2 19696.9 17565.6 17686.4 17702.2 18358.9 18550.3 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#3] mootools.html Cycles:180 Average:10732.47 Median:26774.03 stddev:8088.59 (30.2%) stddev-sans-first:8081.00 01:45:06 INFO - PID 11126 | Values: 1416.3 1484.1 1487.5 1495.8 1497.2 17321.8 17940.3 17981.1 17994.7 18007.8 17327.2 17443.7 17473.8 17485.6 17486.5 2895.1 2939.6 2979.9 2987.0 2987.1 2857.7 2904.0 2907.3 2913.6 2926.2 2842.7 2846.2 2936.9 2944.2 2949.6 2881.6 2908.5 2914.1 2927.1 2941.6 2777.9 2813.2 2843.2 2850.1 2860.1 16820.8 16898.5 16987.0 17018.4 17021.2 8218.1 8536.8 8541.5 8545.5 8554.4 5561.7 5726.2 5783.6 5800.5 5893.7 2142.9 2208.9 2211.3 2243.3 2249.6 31220.5 31412.7 31591.0 31604.7 31668.2 6738.6 6925.0 6955.2 6980.9 7098.8 20319.2 20394.6 20501.4 20512.0 20576.9 8181.9 8261.6 8276.4 8283.8 8308.8 7466.7 7585.7 7628.6 7662.5 7677.2 5720.6 5846.9 5970.6 6023.2 6095.7 1468.0 1543.2 1551.3 1578.9 1604.8 1016.2 1018.6 1021.0 1023.2 1036.3 8805.6 8977.4 9015.0 9096.2 9133.5 1086.4 1089.3 1095.1 1096.2 1103.3 5409.0 5472.6 5517.9 5523.5 5546.4 26478.6 27048.3 27268.2 27280.7 27306.9 25538.5 25821.2 26048.9 26488.2 26499.7 12555.5 12959.1 13032.5 13036.6 13039.5 9594.7 9821.0 9896.5 9904.2 9968.7 21739.9 21779.6 21850.8 22268.3 22394.1 22933.0 23237.4 23319.4 23407.6 23625.4 12233.8 12335.3 12473.7 12495.4 12502.4 15129.0 15343.9 15357.2 15360.2 15381.5 12520.2 12521.0 12582.6 12672.6 12940.3 12336.6 12437.2 12441.1 12501.7 12525.9 10878.1 11122.2 11180.8 11189.4 11200.2 8951.0 8968.5 9003.3 9039.4 9186.8 8566.8 8586.0 8600.5 8708.1 8767.7 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#4] prototype.html Cycles:180 Average:5817.48 Median:6455.66 stddev:1611.64 (25.0%) stddev-sans-first:1567.24 01:45:06 INFO - PID 11126 | Values: 566.7 570.7 573.5 604.4 607.7 6400.8 6454.4 6522.8 6550.5 6576.3 6392.6 6417.5 6456.9 6469.6 6540.7 5340.0 5352.9 5359.4 5373.6 5388.2 5025.3 5148.3 5321.3 5350.1 5399.6 5116.4 5138.0 5153.0 5159.4 5163.3 5122.8 5133.7 5174.2 5184.5 5195.8 4644.0 4650.9 4653.9 4656.3 4670.1 6203.1 6249.7 6307.4 6395.4 6427.9 5942.6 6016.7 6041.2 6097.3 6112.3 6818.2 6835.8 6877.7 6878.5 6930.9 5223.1 5236.9 5241.9 5261.3 5276.4 6864.7 7053.5 7071.6 7077.8 7167.8 5369.0 5389.3 5389.8 5423.2 5449.5 5395.8 5468.5 5481.4 5485.5 5519.3 6060.0 6097.5 6101.7 6111.1 6124.0 6921.3 6922.3 6937.1 6988.7 6993.5 1850.2 1877.7 1886.9 1892.1 1899.2 1287.8 1322.8 1343.7 1356.2 1357.6 6345.9 6356.9 6360.3 6370.4 6372.6 6884.7 6934.2 6948.7 6999.3 7038.4 6403.6 6433.7 6459.7 6465.5 6503.2 3655.3 3683.9 3690.8 3696.8 3708.3 6971.8 7019.6 7021.0 7160.8 7260.2 7025.7 7049.6 7081.4 7124.5 7202.2 7240.8 7253.9 7264.3 7301.7 7309.4 6929.8 6973.7 6978.5 6979.0 7032.7 6885.6 6917.6 6927.7 6952.1 7019.5 7086.6 7198.6 7225.6 7255.4 7297.9 5364.4 5403.7 5407.3 5409.8 5454.1 6693.8 6721.7 6902.1 6992.9 6998.2 6625.1 6656.6 6743.2 6746.5 6797.7 6515.0 6598.4 6626.2 6693.7 6696.6 6534.4 6549.4 6569.5 6651.7 6745.2 6676.8 6746.7 6775.8 6804.0 6822.6 6539.2 6599.3 6618.3 6639.8 6674.2 01:45:06 INFO - PID 11126 | 01:45:06 INFO - PID 11126 | [#5] yui.html Cycles:180 Average:31022.68 Median:20764.09 stddev:45382.09 (218.6%) stddev-sans-first:45453.35 01:45:06 INFO - PID 11126 | Values: 983.9 1016.1 1018.2 1027.2 1040.4 20566.6 20855.6 20923.6 20958.6 21035.6 19576.0 20045.3 20427.3 20554.0 20628.2 1059.2 1068.3 1070.8 1071.0 1071.9 1056.1 1065.9 1067.4 1073.8 1114.6 1184.0 1184.3 1187.6 1190.6 1191.7 1163.7 1173.2 1176.4 1179.0 1179.4 857.4 858.6 861.6 862.5 863.3 20838.0 21288.0 21334.6 21440.6 23093.0 23920.9 23932.5 24302.3 24528.1 24578.9 19805.5 19909.4 20140.2 20152.5 20182.7 3991.6 4017.4 4020.1 4051.0 4055.4 163562.0 168027.0 169251.2 170865.0 171508.0 17520.7 17962.6 18083.0 18100.0 18331.4 34835.7 34966.8 35849.8 35850.5 35905.3 9758.9 9846.8 9890.1 9929.3 9999.2 4741.1 4748.8 4771.6 4779.9 4782.9 5651.2 5679.5 5687.8 5771.5 5786.2 1150.0 1174.1 1178.7 1179.2 1190.6 751.9 770.8 781.7 789.7 798.0 12543.3 13308.3 14170.5 14317.0 14554.3 775.3 786.6 789.1 791.2 794.8 6270.6 6341.6 6354.4 6484.3 6509.2 158119.2 158286.0 159513.0 159774.0 161716.0 131541.0 133051.3 136444.0 139236.0 142018.0 114989.0 121026.4 121072.0 123210.0 127782.4 14190.9 14558.8 14638.2 14706.4 14706.6 55236.7 55342.7 55824.7 57111.0 57211.0 100378.0 100404.0 101769.5 102225.0 103216.5 21593.8 22035.3 22080.7 22366.1 22388.2 24077.5 24846.9 25012.4 25266.0 25284.0 22590.4 22952.9 23207.7 23463.6 23510.8 20690.2 21303.3 21328.7 21560.0 22092.2 22089.4 22491.7 22614.4 22787.3 22845.2 12954.5 13545.6 13952.3 13977.6 14433.8 15785.7 16066.7 16238.4 16587.4 16694.4 01:45:06 INFO - PID 11126 | -------- Summary: end -------- 01:45:06 INFO - PID 11126 | 01:45:07 INFO - TEST-INFO | 11126: exit 0 01:45:07 INFO - TEST-OK | dromaeo_css | took 1107109ms 01:45:07 INFO - TEST-START | kraken 01:45:07 INFO - Initialising browser for kraken test... 01:45:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57767/getInfo.html -profile /tmp/tmpl7m8yB/profile 01:45:07 INFO - TEST-INFO | started process 11486 (/builds/slave/test/build/application/firefox/firefox http://localhost:57767/getInfo.html) 01:45:12 INFO - TEST-INFO | 11486: exit 0 01:45:12 INFO - Browser initialized. 01:45:12 INFO - Running cycle 1/1 for kraken test... 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'JSGC_DISABLE_POISONING': '1', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:45:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:45:12 INFO - 'MOZ_CRASHREPORTER': '1', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:45:12 INFO - 'RUST_BACKTRACE': 'full', 01:45:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:12 INFO - TEST-INFO | started process 11677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl7m8yB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:23 INFO - PID 11677 | RSS: Main: 144109568 01:45:23 INFO - PID 11677 | 01:45:26 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57767/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:27 INFO - PID 11677 | RSS: Main: 149786624 01:45:27 INFO - PID 11677 | 01:45:29 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57767/tests/kraken/driver.html?testName=audio-dft) 01:45:30 INFO - PID 11677 | RSS: Main: 150257664 01:45:30 INFO - PID 11677 | 01:45:33 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57767/tests/kraken/driver.html?testName=audio-fft) 01:45:33 INFO - PID 11677 | RSS: Main: 151744512 01:45:33 INFO - PID 11677 | 01:45:35 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57767/tests/kraken/driver.html?testName=audio-oscillator) 01:45:36 INFO - PID 11677 | RSS: Main: 151470080 01:45:36 INFO - PID 11677 | 01:45:38 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:38 INFO - PID 11677 | RSS: Main: 151179264 01:45:38 INFO - PID 11677 | 01:45:41 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57767/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:42 INFO - PID 11677 | RSS: Main: 150913024 01:45:42 INFO - PID 11677 | 01:45:45 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57767/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:46 INFO - PID 11677 | RSS: Main: 153624576 01:45:46 INFO - PID 11677 | 01:45:49 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57767/tests/kraken/driver.html?testName=json-parse-financial) 01:45:50 INFO - PID 11677 | RSS: Main: 154566656 01:45:50 INFO - PID 11677 | 01:45:51 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:52 INFO - PID 11677 | RSS: Main: 154804224 01:45:52 INFO - PID 11677 | 01:45:53 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:54 INFO - PID 11677 | RSS: Main: 154165248 01:45:54 INFO - PID 11677 | 01:45:56 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:56 INFO - PID 11677 | RSS: Main: 151007232 01:45:56 INFO - PID 11677 | 01:45:59 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:59 INFO - PID 11677 | RSS: Main: 151359488 01:45:59 INFO - PID 11677 | 01:46:02 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:03 INFO - PID 11677 | RSS: Main: 151547904 01:46:03 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | Cycle 1(1): loaded http://localhost:57767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57767/tests/kraken/driver.html?testName=ai-astar) 01:46:04 INFO - PID 11677 | RSS: Main: 152801280 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | __start_tp_report 01:46:04 INFO - PID 11677 | _x_x_mozilla_page_load 01:46:04 INFO - PID 11677 | _x_x_mozilla_page_load_details 01:46:04 INFO - PID 11677 | |i|pagename|runs| 01:46:04 INFO - PID 11677 | |0;ai-astar;105;105;105;104;106;105;106;105;104;106 01:46:04 INFO - PID 11677 | |1;audio-beat-detection;110;114;112;119;111;114;113;109;143;111 01:46:04 INFO - PID 11677 | |2;audio-dft;161;160;162;162;162;164;160;163;161;162 01:46:04 INFO - PID 11677 | |3;audio-fft;73;73;82;73;74;72;73;74;74;75 01:46:04 INFO - PID 11677 | |4;audio-oscillator;77;78;79;76;76;75;75;76;77;77 01:46:04 INFO - PID 11677 | |5;imaging-gaussian-blur;114;113;113;110;113;114;113;113;115;115 01:46:04 INFO - PID 11677 | |6;imaging-darkroom;149;148;147;148;149;149;149;147;148;148 01:46:04 INFO - PID 11677 | |7;imaging-desaturate;94;94;96;94;94;94;94;94;99;99 01:46:04 INFO - PID 11677 | |8;json-parse-financial;46;43;43;44;44;43;43;44;42;43 01:46:04 INFO - PID 11677 | |9;json-stringify-tinderbox;37;37;37;38;37;37;38;37;37;38 01:46:04 INFO - PID 11677 | |10;stanford-crypto-aes;70;67;68;70;70;71;71;71;69;68 01:46:04 INFO - PID 11677 | |11;stanford-crypto-ccm;99;99;100;105;102;105;105;102;110;101 01:46:04 INFO - PID 11677 | |12;stanford-crypto-pbkdf2;159;154;148;146;154;158;145;156;145;150 01:46:04 INFO - PID 11677 | |13;stanford-crypto-sha256-iterative;56;59;60;60;58;59;57;59;59;58 01:46:04 INFO - PID 11677 | __end_tp_report 01:46:04 INFO - PID 11677 | __start_cc_report 01:46:04 INFO - PID 11677 | _x_x_mozilla_cycle_collect,718 01:46:04 INFO - PID 11677 | __end_cc_report 01:46:04 INFO - PID 11677 | __startTimestamp1506069964982__endTimestamp 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | ------- Summary: start ------- 01:46:04 INFO - PID 11677 | Number of tests: 14 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 01:46:04 INFO - PID 11677 | Values: 105.0 105.0 105.0 104.0 106.0 105.0 106.0 105.0 104.0 106.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#1] audio-beat-detection Cycles:10 Average:115.60 Median:113.50 stddev:10.02 (8.8%) stddev-sans-first:10.43 01:46:04 INFO - PID 11677 | Values: 110.0 114.0 112.0 119.0 111.0 114.0 113.0 109.0 143.0 111.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 01:46:04 INFO - PID 11677 | Values: 161.0 160.0 162.0 162.0 162.0 164.0 160.0 163.0 161.0 162.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:2.83 (3.8%) stddev-sans-first:2.96 01:46:04 INFO - PID 11677 | Values: 73.0 73.0 82.0 73.0 74.0 72.0 73.0 74.0 74.0 75.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.00 stddev:1.26 (1.6%) stddev-sans-first:1.33 01:46:04 INFO - PID 11677 | Values: 77.0 78.0 79.0 76.0 76.0 75.0 75.0 76.0 77.0 77.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:1.42 (1.2%) stddev-sans-first:1.48 01:46:04 INFO - PID 11677 | Values: 114.0 113.0 113.0 110.0 113.0 114.0 113.0 113.0 115.0 115.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:46:04 INFO - PID 11677 | Values: 149.0 148.0 147.0 148.0 149.0 149.0 149.0 147.0 148.0 148.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.10 (2.2%) stddev-sans-first:2.18 01:46:04 INFO - PID 11677 | Values: 94.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 99.0 99.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:43.50 stddev:1.08 (2.5%) stddev-sans-first:0.67 01:46:04 INFO - PID 11677 | Values: 46.0 43.0 43.0 44.0 44.0 43.0 43.0 44.0 42.0 43.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 01:46:04 INFO - PID 11677 | Values: 37.0 37.0 37.0 38.0 37.0 37.0 38.0 37.0 37.0 38.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 01:46:04 INFO - PID 11677 | Values: 70.0 67.0 68.0 70.0 70.0 71.0 71.0 71.0 69.0 68.0 01:46:04 INFO - PID 11677 | 01:46:04 INFO - PID 11677 | [#11] stanford-crypto-ccm Cycles:10 Average:102.80 Median:105.00 stddev:3.46 (3.3%) stddev-sans-first:3.38 01:46:04 INFO - PID 11677 | Values: 99.0 99.0 100.0 105.0 102.0 105.0 105.0 102.0 110.0 101.0 01:46:04 INFO - PID 11677 | 01:46:05 INFO - PID 11677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:154.00 stddev:5.38 (3.5%) stddev-sans-first:4.97 01:46:05 INFO - PID 11677 | Values: 159.0 154.0 148.0 146.0 154.0 158.0 145.0 156.0 145.0 150.0 01:46:05 INFO - PID 11677 | 01:46:05 INFO - PID 11677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.50 Median:59.00 stddev:1.27 (2.2%) stddev-sans-first:0.97 01:46:05 INFO - PID 11677 | Values: 56.0 59.0 60.0 60.0 58.0 59.0 57.0 59.0 59.0 58.0 01:46:05 INFO - PID 11677 | -------- Summary: end -------- 01:46:05 INFO - PID 11677 | 01:46:05 INFO - PID 11677 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:46:05 INFO - TEST-INFO | 11677: exit 0 01:46:05 INFO - TEST-OK | kraken | took 58234ms 01:46:05 INFO - SUITE-END | took 1165s 01:46:05 INFO - Completed test suite (00:19:25) 01:46:05 INFO - javascript benchmark 01:46:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9480.55097985795, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3982.8805135845937, 3990.740601860879, 4004.919901601968, 4054.5337286212093, 4082.122343696107, 6584.242812076613, 6613.669316534172, 6615.867682646344, 6683.632400217986, 6718.46252299816, 6657.833554161149, 6671.566348187364, 6706.0276259942275, 6707.664616769154, 6762.62805545696, 5971.134185543094, 5985.4912332451795, 6033.1855199548045, 6061.515078793708, 6085.695715214244, 6021.909671354933, 6036.034234522477, 6038.69806509675, 6042.57701960863, 6105.20632317798, 5980.0, 5982.312034116088, 6012.3687012863675, 6015.09773533969, 6103.115048317991, 6053.394660533933, 6056.818295451144, 6110.633361998272, 6123.816285511397, 6131.846703832395, 6021.608595441282, 6050.667213303266, 6068.423499767515, 6112.51099912006, 6130.080487926846, 6490.513211509156, 6584.9012264816065, 6620.3710647488415, 6688.565243259172, 6691.665416729193, 7196.46026548011, 7239.746608868717, 7248.420126389876, 7259.818504537376, 7277.781666550012, 7222.0, 7232.710691572331, 7313.378362839112, 7324.6337683115635, 7324.780256592311, 6729.798106056826, 6753.628550429725, 6806.18325800907, 6814.557053791487, 6816.4546836252985, 7290.71928506467, 7320.890186647204, 7339.045924029842, 7400.222976587488, 7483.363914067257, 7148.213696493382, 7196.280371962762, 7216.819579510449, 7222.819429514304, 7233.0, 7241.0, 7277.126744790659, 7308.232635573295, 7338.302861228175, 7347.5224110432655, 7124.0, 7205.063341765537, 7207.96396018027, 7214.603196824225, 7233.095863017123, 7149.463790215755, 7170.139583250043, 7225.8554828903125, 7234.204237533867, 7237.782866514013, 5330.92003619946, 5352.678839269578, 5352.678839269656, 5418.322709661293, 5421.1055175895535, 4847.515248475124, 4875.975620121948, 4882.414110306715, 4921.409430868319, 4926.1379258629595, 6595.241547222035, 6661.533692641566, 6667.299933507009, 6704.2625311215725, 6760.0535924970545, 7144.071270734875, 7208.675609597581, 7225.494215404871, 7231.16841563227, 7233.421326293884, 6610.206775187008, 6616.900746488806, 6696.7656132035145, 6701.966490167518, 6716.361945615159, 6188.133661287423, 6261.405166509175, 6278.529110316745, 6280.466160376419, 6281.340459251713, 7468.103827540621, 7471.103467583925, 7491.400687945061, 7547.320741133324, 7567.31894129531, 7143.071400717873, 7181.533200341961, 7274.527155734861, 7275.781726548, 7327.560346379128, 7386.956801393263, 7498.512596681198, 7508.0990281166605, 7588.089429268523, 7603.163651998165, 7127.714891404493, 7157.677904494414, 7198.5320954137815, 7237.855242895218, 7256.7460138894885, 7062.8940565890525, 7258.528195667264, 7286.234945330664, 7368.926310736824, 7376.668049937873, 6896.241413444417, 6944.131983502062, 7033.402160816388, 7033.824154396181, 7094.822629434306, 6988.37104660583, 6994.545354551938, 7041.6831242595235, 7087.397571206299, 7092.432605391453, 6899.586024838526, 6907.13660792401, 6911.067005954132, 6997.860042799014, 7013.0, 6879.105716256855, 7048.0, 7089.964550177217, 7150.570965742072, 7159.749408770668, 6714.630695311805, 6849.24658287598, 6885.173779146334, 6933.341332573397, 6955.234924158237], "value": 6631.676978481775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [973.6202880876457, 983.8524221366798, 988.9505524723764, 1035.818731721949, 1036.8185567525682, 43404.78297608515, 45355.31967020493, 45560.3165952511, 45604.77197614012, 45674.0, 41902.371464428055, 41948.37077443841, 42108.0, 42209.36685949713, 42559.574404255945, 8010.1589333120055, 8113.553754543498, 8119.634616442274, 8121.4721043132, 8128.105908350077, 8076.273135417811, 8112.797180070486, 8136.3084137848355, 8143.307818835406, 8152.959235203815, 8414.83170336593, 8549.273311768507, 8549.743507694748, 8551.615177317035, 8562.357823163256, 8443.282321002722, 8503.532305723184, 8503.61733721984, 8506.914930850706, 8514.361422893307, 8803.29573634114, 8884.20042196199, 8887.822243555158, 8890.73327800167, 8897.332700047458, 40284.194316113804, 40776.59223407758, 40785.59214407847, 40789.592104078874, 40913.38629920524, 3794.1083845296334, 3830.042489377656, 3833.271678381099, 3842.1739326044753, 3849.0377405648587, 33201.6679833201, 33497.497537536954, 33560.83219583911, 33696.32607347839, 33752.32495350079, 5636.718164091779, 5641.0, 5672.035753921843, 5683.658980461186, 5727.083666613322, 221995.0, 222528.0, 222716.0, 223103.0, 223423.0, 51215.23177152346, 51419.742901286, 51499.742501288005, 51594.22608660873, 51620.22569661458, 54838.45161548333, 55145.172822407694, 55150.17274740882, 55153.44846551483, 55260.0, 18259.087045647666, 18609.162587683317, 18614.627707445776, 18715.625687486445, 18758.437246882615, 15338.693226135638, 15398.07611543311, 15418.229088545751, 15436.768448473282, 15450.381984720485, 15284.0, 15391.692166156614, 15416.229188540752, 15620.84379156194, 15639.609009774618, 6026.758929642765, 6225.782097626561, 6240.126382306481, 6240.843978900564, 6258.906116408258, 1091.9344839309667, 1111.9610813621484, 1112.038087054692, 1115.5314767797545, 1116.1015382616908, 25592.0, 25668.229953101436, 25919.481610367686, 25939.610905836427, 26054.0, 1229.9938500307442, 1232.6918270432393, 1233.6545767185203, 1240.3736113262926, 1256.5162412471263, 13626.795598066037, 13694.52069177574, 13739.793903091462, 13848.0, 14023.439062437592, 288680.0, 310821.0, 312730.0, 313266.0, 316383.0, 62302.68848655818, 62586.374136258964, 62616.0, 63046.68476657679, 63062.68468657719, 1444.6740747396682, 1446.4864972934456, 1459.9489017884323, 1472.9631759206106, 1530.8163020437619, 30035.249118772204, 30422.239444014078, 30557.388852223277, 30643.54034689437, 30996.450177491486, 40917.79541102275, 40960.79519602383, 41089.38365924573, 41112.79443602763, 41134.794326029376, 271221.0, 271324.0, 271514.0, 272854.0, 273653.0, 37121.443178352885, 37262.06844828901, 37314.253714925006, 37429.43855842219, 37584.43623345707, 43440.78279608582, 45779.0, 46076.0, 46165.0, 46180.769096154305, 33935.3212935735, 33962.66037339694, 34170.0, 34289.657103428646, 34404.48393274153, 34204.0, 34305.82847085749, 34458.655413445544, 34751.65248347585, 34968.475472867416, 39048.82853514399, 39946.0, 39956.40065398963, 40143.799281003405, 40361.39457908193, 32648.836755816068, 33248.833755832035, 33302.5004624926, 33398.83300583579, 33403.16492087717, 25168.0, 25221.0, 25320.493590128463, 25544.23367298984, 25762.0], "value": 19110.38917687401, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.1647725654391, 641.9149975574011, 642.5655748911154, 655.1394040923776, 655.3708439897698, 22553.210637627686, 24210.757892421094, 24752.0, 24753.009879604793, 24990.250292491208, 26332.73667263327, 26627.06805261816, 26651.333716657093, 26775.0, 26819.195424137306, 6529.640869752162, 6868.484863635223, 6886.690098945534, 6990.720371185159, 7128.251533588977, 6814.114165158548, 6911.170659520864, 6926.445884329267, 6929.133858267692, 6941.132358455193, 6601.5708978916455, 6832.145981752281, 6880.346367095118, 6915.204751453597, 6916.65416729164, 6886.655667216644, 6917.412019978283, 6922.688479018431, 6947.062146610194, 6949.617771022592, 6467.51493637979, 6501.6749162542155, 6506.186726659168, 6526.836829079263, 6530.673466326664, 29153.41693166146, 29946.0, 30601.08196754101, 30717.846410768027, 30775.692243077505, 2365.8698771567556, 2415.927522174338, 2418.22616762636, 2423.6728041714496, 2427.1990243219693, 20374.694379584318, 20672.379828605164, 20792.896035519876, 20808.16767329305, 21020.789792102038, 2546.579814330652, 2608.334874606982, 2642.696089949661, 2648.9867550662316, 2661.5874539446418, 141829.0, 144519.27740361335, 146420.99999999892, 154130.22934885253, 161155.1942240293, 16147.0, 16483.6703265934, 16900.492985210465, 17157.656846863243, 17619.823801762075, 26864.32839178997, 26877.462450751267, 26884.193474195807, 26899.0, 26912.59631105535, 11542.769144617061, 11549.307041577533, 11666.766664666658, 11841.5855445059, 11916.285022898654, 10579.31234469757, 10670.039696427204, 10686.625968091079, 10746.0, 10839.349639021684, 9768.169705574963, 10039.297249192632, 10307.896921030693, 10321.84517232242, 10335.793284134275, 3069.0204817892336, 3104.0842951329414, 3114.8286844223785, 3138.325260069096, 3156.163616641592, 1048.5163493656544, 1056.6460235821087, 1061.6708820265587, 1065.387402243713, 1070.0369667299492, 20358.694619580718, 20868.0, 21306.78693213079, 21520.0, 21543.46141346479, 1117.044926587772, 1125.5329038448951, 1127.8702949160952, 1131.3438205840594, 1137.4851708221636, 11352.48913798881, 11413.0, 11711.472983715754, 11745.412729363668, 11786.705332366588, 605014.0, 615626.0, 619744.0, 625097.0, 641415.0, 122277.0, 124209.0, 124936.37531812282, 125172.37413812873, 129110.35444822715, 1139.5072455083866, 1181.1082632612495, 1182.4619797991893, 1259.9811002834965, 1265.8544267409181, 23076.4230894229, 23589.646155307342, 23608.29175124749, 23734.762652373945, 23937.640935385636, 64582.35417645764, 66407.33592664011, 67164.32835671776, 67974.0, 68082.0, 84931.0, 85688.57155714181, 86160.56919715612, 86692.0, 87359.1264087351, 20463.79536204619, 20898.37304880856, 21186.682199767325, 21276.255331063338, 21277.46806329854, 23252.3024309271, 23558.293251202493, 23652.408689782893, 23797.167099151447, 23833.88083059643, 19451.51371215731, 19597.70603440978, 19599.510012249808, 19761.802381975995, 19853.0, 16935.0, 17190.484285471455, 17242.741358879877, 17296.308147673953, 18375.908120459313, 18622.81377186265, 18648.906755466134, 18703.158357873657, 18884.716729248797, 19592.510187245432, 19257.903710481358, 19446.8055319445, 19495.415137545897, 19591.216351345785, 19696.90151549233, 17565.648687026445, 17686.380976665754, 17702.203400846734, 18358.908205459422, 18550.257989680802], "value": 13282.298244893296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.2847761880248, 1484.109534279433, 1487.4645127754006, 1495.7681559358296, 1497.1765528959077, 17321.82678173218, 17940.282388704454, 17981.100944952734, 17994.65040121991, 18007.81992180078, 17327.22027508762, 17443.651126977453, 17473.825261747377, 17485.562860928483, 17486.47540573785, 2895.1459319500796, 2939.58845761593, 2979.942120547207, 2986.970130298691, 2987.1337312179444, 2857.6570811502647, 2904.0271509044496, 2907.331313797828, 2913.562965555173, 2926.239177813773, 2842.715728427151, 2846.2315174902765, 2936.9265768355854, 2944.175630823362, 2949.6460424748952, 2881.625388699466, 2908.476474234637, 2914.096630044682, 2927.1072322941495, 2941.558766185068, 2777.916662500128, 2813.22636275024, 2843.175479111055, 2850.144956513038, 2860.0847728726817, 16820.83179168205, 16898.493045208663, 16987.0, 17018.404355847484, 17021.23404446803, 8218.096009438957, 8536.78658033548, 8541.487510749314, 8545.529995850226, 8554.35842311829, 5561.721913904329, 5726.169705392736, 5783.62406443584, 5800.535957123462, 5893.734781934781, 2142.924997625076, 2208.9149746192907, 2211.3034394165948, 2243.32700189944, 2249.5725812095648, 31220.531692024637, 31412.685873141432, 31590.998855108726, 31604.683953160406, 31668.208294792585, 6738.59568425896, 6925.0, 6955.234924158339, 6980.930190698028, 7098.822529436806, 20319.18723251083, 20394.592108157754, 20501.38495845127, 20512.0, 20576.897115514326, 8181.877271840927, 8261.586920653943, 8276.420650554524, 8283.751487455385, 8308.792280192923, 7466.701331946661, 7585.6965721370525, 7628.580428076509, 7662.5402475850515, 7677.193894640982, 5720.570957178228, 5846.941530584725, 5970.611910225908, 6023.216981792339, 6095.664738439428, 1467.9926600367144, 1543.2052492966131, 1551.2631500037392, 1578.8973716708376, 1604.8314926932737, 1016.2124353625999, 1018.556927736437, 1021.0453226233495, 1023.1610079734546, 1036.3212096077082, 8805.559722014003, 8977.371583989057, 9015.0, 9096.226820720312, 9133.543322833832, 1086.4079076903106, 1089.2919602258596, 1095.0965453500735, 1096.1942971915635, 1103.2828661370174, 5409.0263752524925, 5472.616916815864, 5517.915276967595, 5523.475269849358, 5546.417626149277, 26478.6028209577, 27048.323791904968, 27268.181954541396, 27280.727192728216, 27306.86346568294, 25538.489230215662, 25821.225363239133, 26048.8697556511, 26488.205353839414, 26499.73500265011, 12555.497780088694, 12959.092863499653, 13032.54386096501, 13036.608901732963, 13039.543615973585, 9594.712158635251, 9821.0, 9896.455694936847, 9904.158146557624, 9968.651097211563, 21739.891300543397, 21779.564408712053, 21850.781492184873, 22268.331950041524, 22394.104235830386, 22933.0, 23237.41906452352, 23319.41701457477, 23407.648885267074, 23625.40936476602, 12233.755324893631, 12335.259884406963, 12473.688157796129, 12495.437705303464, 12502.374881255719, 15129.0, 15343.923280383528, 15357.232138392812, 15360.23198840076, 15381.461648842236, 12520.248785072925, 12521.0, 12582.622521324009, 12672.556460523838, 12940.288284144463, 12336.62990110298, 12437.191582547106, 12441.129120961446, 12501.749965000467, 12525.93737031309, 10878.12974962017, 11122.221444498808, 11180.776384472103, 11189.440527973731, 11200.21598488098, 8950.955245223733, 8968.506732129796, 9003.324750643858, 9039.412438191497, 9186.816263674555, 8566.82866342682, 8586.0, 8600.483970961763, 8708.129187081242, 8767.693130740394], "value": 7485.183734199391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6965978250024, 570.6690119730557, 573.5039191099698, 604.356360476093, 607.6991889014938, 6400.839979000527, 6454.386833250839, 6522.8043158705195, 6550.508711846613, 6576.342365763421, 6392.6484043377595, 6417.486601071914, 6456.935430645693, 6469.57947733397, 6540.705668244928, 5340.038793017256, 5352.892942141155, 5359.410464848864, 5373.623846330758, 5388.191771234327, 5025.296458495814, 5148.34075161979, 5321.3348331458565, 5350.121162157444, 5399.595030372738, 5116.411612664554, 5138.02186158328, 5153.0, 5159.432462429129, 5163.251328557357, 5122.795088196468, 5133.666311689728, 5174.2238664200295, 5184.5483264685945, 5195.844124676266, 4643.95356046442, 4650.883727906796, 4653.906921861544, 4656.278276867091, 4670.112678591091, 6203.131561581382, 6249.687515624246, 6307.432331090224, 6395.424411802914, 6427.903581446282, 5942.554308426842, 6016.729247183844, 6041.214642096544, 6097.3292937776805, 6112.266528016622, 6818.2159051709195, 6835.829104272433, 6877.695971849436, 6878.454971660468, 6930.896036559456, 5223.112070947948, 5236.869078273074, 5241.9213711794355, 5261.263423120766, 5276.3932147802725, 6864.73463756959, 7053.470989675743, 7071.575705457689, 7077.823054423629, 7167.784966451015, 5368.9731551342775, 5389.299391079135, 5389.784408623611, 5423.2136340230445, 5449.47414723878, 5395.757190926418, 5468.507834294853, 5481.369642491165, 5485.451454854562, 5519.282493275929, 6059.970119870237, 6097.512199024068, 6101.694915254219, 6111.113888486234, 6124.0, 6921.307869213139, 6922.307769223037, 6937.063496428019, 6988.650567471606, 6993.545419547713, 1850.1674246589089, 1877.7465042219399, 1886.858485613557, 1892.1107079672531, 1899.164367678217, 1287.819705241267, 1322.8280323558067, 1343.7312537492542, 1356.1727346318737, 1357.6198664373992, 6345.936540634627, 6356.872862542816, 6360.332165122688, 6370.426661600478, 6372.617642941438, 6884.65576721162, 6934.237233904368, 6948.722051117898, 6999.255398361852, 7038.40173585251, 6403.551751377452, 6433.678316084177, 6459.677016149174, 6465.4827613790785, 6503.219613646393, 3655.2689462107683, 3683.8710645127826, 3690.7785532868115, 3696.8336424860945, 3708.332500149999, 6971.825704357431, 7019.5788252705, 7020.964895175492, 7160.785176444715, 7260.165081015751, 7025.683844227022, 7049.612271325023, 7081.433485321162, 7124.46566507514, 7202.243764404767, 7240.782776516713, 7253.891191632024, 7264.34620884123, 7301.671424785897, 7309.4152467803515, 6929.826754331182, 6973.721051157897, 6978.546394484342, 6978.953157026486, 7032.683529241299, 6885.586864788129, 6917.584944903322, 6927.7228910843005, 6952.061471701458, 7019.543729657556, 7086.574805511686, 7198.604076775828, 7225.6387180641805, 7255.383292420203, 7297.890531641923, 5364.436734142859, 5403.729813509387, 5407.324084489439, 5409.810656626999, 5454.127339625641, 6693.799186024427, 6721.731130754715, 6902.137232845895, 6992.895106573304, 6998.16022077354, 6625.103657744708, 6656.600603963778, 6743.224529179207, 6746.460283177236, 6797.660116994031, 6515.0, 6598.406143447113, 6626.204855417381, 6693.665316734241, 6696.5647232929705, 6534.411902928569, 6549.410553050057, 6569.507286953593, 6651.667416629246, 6745.156855393076, 6676.76479851229, 6746.684396542627, 6775.830604234933, 6804.0, 6822.624755638488, 6539.247986481425, 6599.274079851309, 6618.338166183343, 6639.767608133692, 6674.16572928384], "value": 5354.584834584487, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [983.8819341679, 1016.060144366461, 1018.2007124407342, 1027.1577306608583, 1040.3653771199567, 20566.588668226646, 20855.582888342262, 20923.581528369425, 20958.580828383463, 21035.57928841422, 19576.0, 20045.298414555495, 20427.285045023425, 20554.0, 20628.17487300506, 1059.1579694143156, 1068.2575609951086, 1070.7804899995483, 1071.0146665068137, 1071.935683858971, 1056.0812093478685, 1065.8614380130573, 1067.3809190669392, 1073.8335557988523, 1114.5653195253817, 1183.9585614503494, 1184.319016565474, 1187.56653821355, 1190.6309044196285, 1191.696117490039, 1163.7497937943383, 1173.1729130962651, 1176.3765204441659, 1178.9528418863235, 1179.4338717415646, 857.3612658569343, 858.5707146426787, 861.6165806216236, 862.529921192945, 863.3007264116086, 20838.0, 21288.0, 21334.573308533898, 21440.571188576298, 23093.0, 23920.880395598084, 23932.52134957291, 24302.270931872074, 24528.14151504689, 24578.877105614538, 19805.504862378413, 19909.402717918485, 20140.194392224294, 20152.49618759528, 20182.697259541117, 3991.600839915985, 4017.417474466186, 4020.1155745736182, 4050.9797451012555, 4055.371417430303, 163562.0, 168027.0, 169251.15374423173, 170865.0, 171508.0, 17520.737188942177, 17962.5509362267, 18083.0, 18100.0, 18331.35840245585, 34835.65164348375, 34966.825165874514, 35849.82075089608, 35850.46224306637, 35905.281894361964, 9758.853617195748, 9846.753831154278, 9890.060444257928, 9929.30494865367, 9999.150072243796, 4741.051789642085, 4748.786304616231, 4771.570558649669, 4779.856604301876, 4782.928256076161, 5651.15232715096, 5679.488846003796, 5687.800926967537, 5771.509421699118, 5786.1610066540115, 1149.9827502587468, 1174.0724827386439, 1178.7112157521462, 1179.1981452612135, 1190.6487586162102, 751.9436042296741, 770.7726220764888, 781.6912319633713, 789.7235967411475, 797.9746026356105, 12543.310117943418, 13308.26804525741, 14170.504032358818, 14317.0, 14554.345054472575, 775.3022279948092, 786.6420778545748, 789.0886026639241, 791.2325044706625, 794.8251384695358, 6270.561060725797, 6341.587796793194, 6354.3963323484195, 6484.319146489645, 6509.218893732783, 158119.20940395223, 158286.0, 159513.0, 159774.0, 161716.0, 131541.0, 133051.33474332566, 136444.0, 139236.0, 142018.0, 114989.0, 121026.39486802509, 121072.0, 123210.0, 127782.36108819583, 14190.929045354707, 14558.781618275523, 14638.194899280641, 14706.41174353014, 14706.63233419173, 55236.72381638066, 55342.72328638331, 55824.72087639536, 57111.0, 57211.0, 100378.0, 100404.0, 101769.49115254376, 102225.0, 103216.48391757993, 21593.784062159804, 22035.338939831832, 22080.668789968484, 22366.105355785585, 22388.21641242549, 24077.51844963056, 24846.875765621055, 25012.37469063288, 25265.989360426112, 25284.0, 22590.435239118495, 22952.885235573714, 23207.651885222072, 23463.648045279675, 23510.764892350857, 20690.17239310411, 21303.25438609641, 21328.680069799277, 21560.0, 22092.226772062902, 22089.447763806034, 22491.66262506031, 22614.434639133495, 22787.31638050861, 22845.200417985292, 12954.481820727065, 13545.59363219105, 13952.302384880919, 13977.58067257984, 14433.78349324782, 15785.68428631444, 16066.678666426373, 16238.350465981228, 16587.419440319532, 16694.4156954506], "value": 10761.716352053427, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1353.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 104.0, 106.0, 105.0, 106.0, 105.0, 104.0, 106.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 112.0, 119.0, 111.0, 114.0, 113.0, 109.0, 143.0, 111.0], "value": 115.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 162.0, 164.0, 160.0, 163.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 82.0, 73.0, 74.0, 72.0, 73.0, 74.0, 74.0, 75.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 76.0, 76.0, 75.0, 75.0, 76.0, 77.0, 77.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 110.0, 113.0, 114.0, 113.0, 113.0, 115.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 149.0, 149.0, 149.0, 147.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 99.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 43.0, 43.0, 44.0, 44.0, 43.0, 43.0, 44.0, 42.0, 43.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 38.0, 37.0, 37.0, 38.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 70.0, 70.0, 71.0, 71.0, 71.0, 69.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 100.0, 105.0, 102.0, 105.0, 105.0, 102.0, 110.0, 101.0], "value": 102.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 148.0, 146.0, 154.0, 158.0, 145.0, 156.0, 145.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 60.0, 60.0, 58.0, 59.0, 57.0, 59.0, 59.0, 58.0], "value": 58.5, "unit": "score"}]}]} 01:46:05 INFO - Return code: 0 01:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:46:05 INFO - # TBPL SUCCESS # 01:46:05 INFO - Running post-action listener: _package_coverage_data 01:46:05 INFO - Running post-action listener: _resource_record_post_action 01:46:05 INFO - [mozharness: 2017-09-22 08:46:05.781725Z] Finished run-tests step (success) 01:46:05 INFO - Running post-run listener: _resource_record_post_run 01:46:05 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 12288; Write bytes: 376487936; Read time: 164; Write time: 159752 01:46:05 INFO - TinderboxPrint: CPU usage
13.0% 01:46:05 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 164 01:46:05 INFO - TinderboxPrint: I/O write bytes / time
376,487,936 / 159,752 01:46:05 INFO - TinderboxPrint: CPU idle
8,183.2 (87.0%) 01:46:05 INFO - TinderboxPrint: CPU user
1,178.3 (12.5%) 01:46:05 INFO - TinderboxPrint: Swap in / out
0 / 0 01:46:05 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 96284672; Read time: 0; Write time: 54796 01:46:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:46:05 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 12288; Write bytes: 280203264; Read time: 164; Write time: 104956 01:46:06 INFO - Running post-run listener: _upload_blobber_files 01:46:06 INFO - Blob upload gear active. 01:46:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:10 INFO - (blobuploader) - INFO - Done attempting. 01:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:11 INFO - (blobuploader) - INFO - Done attempting. 01:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:12 INFO - (blobuploader) - INFO - Done attempting. 01:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:13 INFO - (blobuploader) - INFO - Done attempting. 01:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:13 INFO - Return code: 0 01:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a4506f1be24a06b87b2956cb938b5d00f8634b3d520b1a1f6d742a51b0f12a3300720816dca74638a557b455806f204654325ceafc4f45ca6d0e5bb65d9e1e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fd6f9a6f83f3fb2954cdd60052d804fe780206806dfbc19998c0ad62508bdca3c38a312f6d26947abbc41494bae22ab7a019316bbd6b872770353806c72a278e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe15bef03a89fcc9e2534a388cf0877b23197e8d4cf5184d548fd857adfb530682ae532d5c0b73c76a41fa0ace73f07aa0b68ba0e02413718de72bdd4e689cce", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7a774729d84e7962d637614d5f27863074f6723c040860eab2935cdb74662f8dc8fd98595d1b4d65b61d756d4d5c76325e32fae57b4c6d03599df8166a2f2b3e"} 01:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:13 INFO - Contents: 01:46:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a4506f1be24a06b87b2956cb938b5d00f8634b3d520b1a1f6d742a51b0f12a3300720816dca74638a557b455806f204654325ceafc4f45ca6d0e5bb65d9e1e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fd6f9a6f83f3fb2954cdd60052d804fe780206806dfbc19998c0ad62508bdca3c38a312f6d26947abbc41494bae22ab7a019316bbd6b872770353806c72a278e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe15bef03a89fcc9e2534a388cf0877b23197e8d4cf5184d548fd857adfb530682ae532d5c0b73c76a41fa0ace73f07aa0b68ba0e02413718de72bdd4e689cce", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7a774729d84e7962d637614d5f27863074f6723c040860eab2935cdb74662f8dc8fd98595d1b4d65b61d756d4d5c76325e32fae57b4c6d03599df8166a2f2b3e"} 01:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:13 INFO - Copying logs to upload dir... 01:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.169682 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-22 01:46:13.487001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 01:46:13.491279) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a4506f1be24a06b87b2956cb938b5d00f8634b3d520b1a1f6d742a51b0f12a3300720816dca74638a557b455806f204654325ceafc4f45ca6d0e5bb65d9e1e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fd6f9a6f83f3fb2954cdd60052d804fe780206806dfbc19998c0ad62508bdca3c38a312f6d26947abbc41494bae22ab7a019316bbd6b872770353806c72a278e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe15bef03a89fcc9e2534a388cf0877b23197e8d4cf5184d548fd857adfb530682ae532d5c0b73c76a41fa0ace73f07aa0b68ba0e02413718de72bdd4e689cce", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7a774729d84e7962d637614d5f27863074f6723c040860eab2935cdb74662f8dc8fd98595d1b4d65b61d756d4d5c76325e32fae57b4c6d03599df8166a2f2b3e"} build_url:https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/FJg4EpomScKAf7QIMHp2Bg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a4506f1be24a06b87b2956cb938b5d00f8634b3d520b1a1f6d742a51b0f12a3300720816dca74638a557b455806f204654325ceafc4f45ca6d0e5bb65d9e1e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fd6f9a6f83f3fb2954cdd60052d804fe780206806dfbc19998c0ad62508bdca3c38a312f6d26947abbc41494bae22ab7a019316bbd6b872770353806c72a278e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe15bef03a89fcc9e2534a388cf0877b23197e8d4cf5184d548fd857adfb530682ae532d5c0b73c76a41fa0ace73f07aa0b68ba0e02413718de72bdd4e689cce", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7a774729d84e7962d637614d5f27863074f6723c040860eab2935cdb74662f8dc8fd98595d1b4d65b61d756d4d5c76325e32fae57b4c6d03599df8166a2f2b3e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 01:46:13.526786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:46:13.527136) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506068739.855311-789198168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 01:46:13.608863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 01:46:13.609208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 01:46:13.609584) ========= ========= Total master_lag: 0.23 =========