builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1505963425.43 results: success (0) revision: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.428615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.430180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.430473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.544073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.544345) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 20:10:25-- 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% 226M=0s 2017-09-20 20:10:25 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125666 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.755633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.755933) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:25.809665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 20:10:25.809988) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf --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=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 20:10:25,898 truncating revision to first 12 chars 2017-09-20 20:10:25,898 Setting DEBUG logging. 2017-09-20 20:10:25,898 attempt 1/10 2017-09-20 20:10:25,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47f7b6c64265?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 20:10:26,916 unpacking tar archive at: mozilla-central-47f7b6c64265/testing/mozharness/ program finished with exit code 0 elapsedTime=1.288861 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 20:10:27.153340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:27.153681) ========= script_repo_revision: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:27.154129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:27.154717) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 20:10:27.295093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-20 20:10:27.298428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:27 INFO - MultiFileLogger online at 20170920 20:10:27 in /builds/slave/test 20:10:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:10:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:27 INFO - {'append_to_log': False, 20:10:27 INFO - 'base_work_dir': '/builds/slave/test', 20:10:27 INFO - 'blob_upload_branch': 'Firefox', 20:10:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:27 INFO - 'branch': 'Firefox', 20:10:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:27 INFO - 'code_coverage': False, 20:10:27 INFO - 'config_files': ('talos/linux_config.py',), 20:10:27 INFO - 'default_actions': ('clobber', 20:10:27 INFO - 'read-buildbot-config', 20:10:27 INFO - 'download-and-extract', 20:10:27 INFO - 'populate-webroot', 20:10:27 INFO - 'create-virtualenv', 20:10:27 INFO - 'install', 20:10:27 INFO - 'setup-mitmproxy', 20:10:27 INFO - 'run-tests'), 20:10:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:27 INFO - 'disable_ccov_upload': False, 20:10:27 INFO - 'disable_stylo': False, 20:10:27 INFO - 'download_minidump_stackwalk': True, 20:10:27 INFO - 'download_symbols': 'ondemand', 20:10:27 INFO - 'enable_stylo': False, 20:10:27 INFO - 'enable_webrender': False, 20:10:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:10:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:27 INFO - 'gecko_profile': False, 20:10:27 INFO - 'gecko_profile_interval': 0, 20:10:27 INFO - 'installer_path': 'installer.exe', 20:10:27 INFO - 'log_level': 'info', 20:10:27 INFO - 'log_name': 'talos', 20:10:27 INFO - 'log_to_console': True, 20:10:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:27 INFO - 'opt_config_files': (), 20:10:27 INFO - 'pip_index': False, 20:10:27 INFO - 'suite': 'dromaeojs-e10s', 20:10:27 INFO - 'system_bits': '32', 20:10:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:27 INFO - 'title': 'talos-linux64-ix-011', 20:10:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:27 INFO - 'use_talos_json': True, 20:10:27 INFO - 'verify': 'False', 20:10:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:27 INFO - 'work_dir': 'build'} 20:10:27 INFO - [mozharness: 2017-09-21 03:10:27.625250Z] Running clobber step. 20:10:27 INFO - Running pre-action listener: _resource_record_pre_action 20:10:27 INFO - Running main action method: clobber 20:10:27 INFO - rmtree: /builds/slave/test/build 20:10:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:28 INFO - Running post-action listener: _resource_record_post_action 20:10:28 INFO - [mozharness: 2017-09-21 03:10:28.577502Z] Finished clobber step (success) 20:10:28 INFO - [mozharness: 2017-09-21 03:10:28.577599Z] Running read-buildbot-config step. 20:10:28 INFO - Running pre-action listener: _resource_record_pre_action 20:10:28 INFO - Running main action method: read_buildbot_config 20:10:28 INFO - Using buildbot properties: 20:10:28 INFO - { 20:10:28 INFO - "project": "", 20:10:28 INFO - "product": "firefox", 20:10:28 INFO - "who": "ryanvm@gmail.com", 20:10:28 INFO - "installer_path": "public/build/target.tar.bz2", 20:10:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 20:10:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:10:28 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 20:10:28 INFO - "stage_platform": "linux64-qr", 20:10:28 INFO - "basedir": "/builds/slave/test", 20:10:28 INFO - "buildnumber": 86, 20:10:28 INFO - "platform": "ubuntu64_hw_qr", 20:10:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:10:28 INFO - "slavebuilddir": "test", 20:10:28 INFO - "taskId": "ODaNCngORimex-dBUqq44w", 20:10:28 INFO - "branch": "mozilla-central", 20:10:28 INFO - "script_repo_revision": "production", 20:10:28 INFO - "revision": "47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf", 20:10:28 INFO - "slavename": "talos-linux64-ix-011", 20:10:28 INFO - "repo_path": "mozilla-central" 20:10:28 INFO - } 20:10:28 INFO - Finding installer, test and symbols from parent task. 20:10:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ODaNCngORimex-dBUqq44w'}, attempt #1 20:10:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ODaNCngORimex-dBUqq44w'}, attempt #1 20:10:29 INFO - Task dependencies: e3qcQ5inSsinAoBQTeRgAQ 20:10:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ'}, attempt #1 20:10:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 20:10:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.test_packages.json 20:10:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.crashreporter-symbols.zip 20:10:29 INFO - Running post-action listener: _resource_record_post_action 20:10:29 INFO - [mozharness: 2017-09-21 03:10:29.934906Z] Finished read-buildbot-config step (success) 20:10:29 INFO - [mozharness: 2017-09-21 03:10:29.935125Z] Running download-and-extract step. 20:10:29 INFO - Running pre-action listener: _resource_record_pre_action 20:10:29 INFO - Running main action method: download_and_extract 20:10:29 INFO - mkdir: /builds/slave/test/build/tests 20:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:29 INFO - trying https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.test_packages.json 20:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:10:30 INFO - Downloaded 989 bytes. 20:10:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:10:30 INFO - Using the following test package requirements: 20:10:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:10:30 INFO - u'common': [u'target.common.tests.zip'], 20:10:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:10:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:10:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:10:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:10:30 INFO - u'mozbase': [u'target.common.tests.zip'], 20:10:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:10:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:10:30 INFO - u'web-platform': [u'target.common.tests.zip', 20:10:30 INFO - u'target.web-platform.tests.tar.gz'], 20:10:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:10:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:10:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.common.tests.zip 20:10:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:10:30 INFO - Fetch https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.common.tests.zip into memory 20:10:33 INFO - Content-Length response header: 54733674 20:10:33 INFO - Bytes received: 54733674 20:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.talos.tests.zip 20:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.talos.tests.zip into memory 20:10:45 INFO - Content-Length response header: 14509184 20:10:45 INFO - Bytes received: 14509184 20:10: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')]} 20:10:45 INFO - trying https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 20:10:45 INFO - Downloading https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:10:50 INFO - Downloaded 61500476 bytes. 20:10:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 20:10:50 INFO - mkdir: /builds/slave/test/properties 20:10:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:10:50 INFO - Writing to file /builds/slave/test/properties/build_url 20:10:50 INFO - Contents: 20:10:50 INFO - build_url:https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 20:10:50 INFO - Running post-action listener: _resource_record_post_action 20:10:50 INFO - Running post-action listener: find_tests_for_verification 20:10:50 INFO - Running post-action listener: set_extra_try_arguments 20:10:50 INFO - [mozharness: 2017-09-21 03:10:50.800944Z] Finished download-and-extract step (success) 20:10:50 INFO - [mozharness: 2017-09-21 03:10:50.801043Z] Running populate-webroot step. 20:10:50 INFO - Running pre-action listener: _resource_record_pre_action 20:10:50 INFO - Running main action method: populate_webroot 20:10:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:10:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['tresize', 20:10:50 INFO - 'tcanvasmark']}, 20:10:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:10:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['dromaeo_css', 20:10:50 INFO - 'kraken']}, 20:10:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'tests': ['damp', 'tps']}, 20:10:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['damp', 'tps']}, 20:10:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:10:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['dromaeo_dom']}, 20:10:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:10:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['basic_compositor_video', 20:10:50 INFO - 'glvideo']}, 20:10:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:10:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['ts_paint_webext', 20:10:50 INFO - 'tp5o_webext']}, 20:10:50 INFO - 'other-e10s': {'tests': ['a11yr', 20:10:50 INFO - 'ts_paint', 20:10:50 INFO - 'tpaint', 20:10:50 INFO - 'sessionrestore', 20:10:50 INFO - 'sessionrestore_many_windows', 20:10:50 INFO - 'sessionrestore_no_auto_restore', 20:10:50 INFO - 'tabpaint']}, 20:10:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['a11yr', 20:10:50 INFO - 'ts_paint', 20:10:50 INFO - 'tpaint', 20:10:50 INFO - 'sessionrestore', 20:10:50 INFO - 'sessionrestore_many_windows', 20:10:50 INFO - 'sessionrestore_no_auto_restore', 20:10:50 INFO - 'tabpaint']}, 20:10:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:10:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:10:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['perf_reftest_singletons']}, 20:10:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['bloom_basic']}, 20:10:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:10:50 INFO - 'tsvgr_opacity', 20:10:50 INFO - 'tart', 20:10:50 INFO - 'tscrollx', 20:10:50 INFO - 'tsvg_static']}, 20:10:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['tsvgx', 20:10:50 INFO - 'tsvgr_opacity', 20:10:50 INFO - 'tart', 20:10:50 INFO - 'tscrollx', 20:10:50 INFO - 'tsvg_static']}, 20:10:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:10:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo'], 20:10:50 INFO - 'tests': ['tp5o']}, 20:10:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:10:50 INFO - 'talos_options': ['--mitmproxy', 20:10:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:10:50 INFO - '--firstNonBlankPaint'], 20:10:50 INFO - 'tests': ['tp6_google', 20:10:50 INFO - 'tp6_youtube', 20:10:50 INFO - 'tp6_amazon', 20:10:50 INFO - 'tp6_facebook']}, 20:10:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo', 20:10:50 INFO - '--mitmproxy', 20:10:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:10:50 INFO - '--firstNonBlankPaint'], 20:10:50 INFO - 'tests': ['tp6_google', 20:10:50 INFO - 'tp6_youtube', 20:10:50 INFO - 'tp6_amazon', 20:10:50 INFO - 'tp6_facebook']}, 20:10:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:10:50 INFO - 'talos_options': ['--stylo-threads=1', 20:10:50 INFO - '--mitmproxy', 20:10:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:10:50 INFO - '--firstNonBlankPaint'], 20:10:50 INFO - 'tests': ['tp6_google', 20:10:50 INFO - 'tp6_youtube', 20:10:50 INFO - 'tp6_amazon', 20:10:50 INFO - 'tp6_facebook']}, 20:10:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--xperf_path', 20:10:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:50 INFO - 'tests': ['tp5n']}, 20:10:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:10:50 INFO - 'talos_options': ['--disable-stylo', 20:10:50 INFO - '--xperf_path', 20:10:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:50 INFO - 'tests': ['tp5n']}}} 20:10:50 INFO - Running post-action listener: _resource_record_post_action 20:10:50 INFO - [mozharness: 2017-09-21 03:10:50.815987Z] Finished populate-webroot step (success) 20:10:50 INFO - [mozharness: 2017-09-21 03:10:50.816086Z] Running create-virtualenv step. 20:10:50 INFO - Running pre-action listener: _resource_record_pre_action 20:10:50 INFO - Running main action method: create_virtualenv 20:10:50 INFO - Creating virtualenv /builds/slave/test/build/venv 20:10:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:10:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:10:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:10:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:51 INFO - Installing pip...............done. 20:10:52 INFO - Return code: 0 20:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:10:52 INFO - Reading from file tmpfile_stdout 20:10:52 INFO - Output received: 20:10:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 20:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:10:52 INFO - Using env: {'DISPLAY': ':0', 20:10:52 INFO - 'HOME': '/home/cltbld', 20:10:52 INFO - 'LANG': 'en_US.UTF-8', 20:10:52 INFO - 'LANGUAGE': 'en_US:en', 20:10:52 INFO - 'LOGNAME': 'cltbld', 20:10:52 INFO - 'MAIL': '/var/mail/cltbld', 20:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:52 INFO - 'MOZ_NO_REMOTE': '1', 20:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:52 INFO - 'NO_EM_RESTART': '1', 20:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:52 INFO - 'PWD': '/builds/slave/test', 20:10:52 INFO - 'SHELL': '/bin/bash', 20:10:52 INFO - 'SHLVL': '1', 20:10:52 INFO - 'TERM': 'linux', 20:10:52 INFO - 'TMOUT': '86400', 20:10:52 INFO - 'USER': 'cltbld', 20:10:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:52 INFO - '_': '/tools/buildbot/bin/python'} 20:10:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:10:53 INFO - Downloading/unpacking pip>=1.5 20:10:53 INFO - Running setup.py egg_info for package pip 20:10:53 INFO - warning: no files found matching 'pip/cacert.pem' 20:10:53 INFO - warning: no files found matching '*.html' under directory 'docs' 20:10:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:10:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:10:53 INFO - Installing collected packages: pip 20:10:53 INFO - Found existing installation: pip 1.1 20:10:53 INFO - Uninstalling pip: 20:10:53 INFO - Successfully uninstalled pip 20:10:53 INFO - Running setup.py install for pip 20:10:53 INFO - warning: no files found matching 'pip/cacert.pem' 20:10:53 INFO - warning: no files found matching '*.html' under directory 'docs' 20:10:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:10:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:10:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:10:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:10:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:10:53 INFO - Successfully installed pip 20:10:53 INFO - Cleaning up... 20:10:53 INFO - Return code: 0 20:10:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:10:53 INFO - Using env: {'DISPLAY': ':0', 20:10:53 INFO - 'HOME': '/home/cltbld', 20:10:53 INFO - 'LANG': 'en_US.UTF-8', 20:10:53 INFO - 'LANGUAGE': 'en_US:en', 20:10:53 INFO - 'LOGNAME': 'cltbld', 20:10:53 INFO - 'MAIL': '/var/mail/cltbld', 20:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:53 INFO - 'MOZ_NO_REMOTE': '1', 20:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:53 INFO - 'NO_EM_RESTART': '1', 20:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:53 INFO - 'PWD': '/builds/slave/test', 20:10:53 INFO - 'SHELL': '/bin/bash', 20:10:53 INFO - 'SHLVL': '1', 20:10:53 INFO - 'TERM': 'linux', 20:10:53 INFO - 'TMOUT': '86400', 20:10:53 INFO - 'USER': 'cltbld', 20:10:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:53 INFO - '_': '/tools/buildbot/bin/python'} 20:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:53 INFO - Downloading/unpacking psutil>=3.1.1 20:10:53 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 20:10:53 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 20:10:53 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 20:10:53 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 20:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:54 INFO - Installing collected packages: psutil 20:10:54 INFO - Running setup.py install for psutil 20:10:55 INFO - building 'psutil._psutil_linux' extension 20:10:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:10:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:10:56 INFO - building 'psutil._psutil_posix' extension 20:10:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:10:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:56 INFO - Successfully installed psutil 20:10:56 INFO - Cleaning up... 20:10:56 INFO - Return code: 0 20:10:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:10:56 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')]} 20:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:56 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')]} 20:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:56 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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:10:56 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 20:10:56 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 20:10:56 INFO - Using env: {'DISPLAY': ':0', 20:10:56 INFO - 'HOME': '/home/cltbld', 20:10:56 INFO - 'LANG': 'en_US.UTF-8', 20:10:56 INFO - 'LANGUAGE': 'en_US:en', 20:10:56 INFO - 'LOGNAME': 'cltbld', 20:10:56 INFO - 'MAIL': '/var/mail/cltbld', 20:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:56 INFO - 'MOZ_NO_REMOTE': '1', 20:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:56 INFO - 'NO_EM_RESTART': '1', 20:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:56 INFO - 'PWD': '/builds/slave/test', 20:10:56 INFO - 'SHELL': '/bin/bash', 20:10:56 INFO - 'SHLVL': '1', 20:10:56 INFO - 'TERM': 'linux', 20:10:56 INFO - 'TMOUT': '86400', 20:10:56 INFO - 'USER': 'cltbld', 20:10:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:56 INFO - '_': '/tools/buildbot/bin/python'} 20:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:10:56 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 20:10:56 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 20:10:56 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 20:10:56 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 20:10:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:10:58 INFO - Installing collected packages: mozsystemmonitor 20:10:58 INFO - Running setup.py install for mozsystemmonitor 20:10:58 INFO - Successfully installed mozsystemmonitor 20:10:58 INFO - Cleaning up... 20:10:58 INFO - Return code: 0 20:10:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:10:58 INFO - Using env: {'DISPLAY': ':0', 20:10:58 INFO - 'HOME': '/home/cltbld', 20:10:58 INFO - 'LANG': 'en_US.UTF-8', 20:10:58 INFO - 'LANGUAGE': 'en_US:en', 20:10:58 INFO - 'LOGNAME': 'cltbld', 20:10:58 INFO - 'MAIL': '/var/mail/cltbld', 20:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:58 INFO - 'MOZ_NO_REMOTE': '1', 20:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:58 INFO - 'NO_EM_RESTART': '1', 20:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:58 INFO - 'PWD': '/builds/slave/test', 20:10:58 INFO - 'SHELL': '/bin/bash', 20:10:58 INFO - 'SHLVL': '1', 20:10:58 INFO - 'TERM': 'linux', 20:10:58 INFO - 'TMOUT': '86400', 20:10:58 INFO - 'USER': 'cltbld', 20:10:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:58 INFO - '_': '/tools/buildbot/bin/python'} 20:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:58 INFO - Downloading/unpacking jsonschema==2.5.1 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:59 INFO - warning: no files found matching '*.txt' 20:10:59 INFO - no previously-included directories found matching 'build' 20:10:59 INFO - no previously-included directories found matching 'dist' 20:10:59 INFO - no previously-included directories found matching '.git*' 20:10:59 INFO - Installing collected packages: jsonschema, functools32 20:10:59 INFO - Running setup.py install for functools32 20:10:59 INFO - warning: no files found matching '*.txt' 20:10:59 INFO - no previously-included directories found matching 'build' 20:10:59 INFO - no previously-included directories found matching 'dist' 20:10:59 INFO - no previously-included directories found matching '.git*' 20:10:59 INFO - Successfully installed jsonschema functools32 20:10:59 INFO - Cleaning up... 20:10:59 INFO - Return code: 0 20:10:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:10:59 INFO - Using env: {'DISPLAY': ':0', 20:10:59 INFO - 'HOME': '/home/cltbld', 20:10:59 INFO - 'LANG': 'en_US.UTF-8', 20:10:59 INFO - 'LANGUAGE': 'en_US:en', 20:10:59 INFO - 'LOGNAME': 'cltbld', 20:10:59 INFO - 'MAIL': '/var/mail/cltbld', 20:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:59 INFO - 'MOZ_NO_REMOTE': '1', 20:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:59 INFO - 'NO_EM_RESTART': '1', 20:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:59 INFO - 'PWD': '/builds/slave/test', 20:10:59 INFO - 'SHELL': '/bin/bash', 20:10:59 INFO - 'SHLVL': '1', 20:10:59 INFO - 'TERM': 'linux', 20:10:59 INFO - 'TMOUT': '86400', 20:10:59 INFO - 'USER': 'cltbld', 20:10:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:59 INFO - '_': '/tools/buildbot/bin/python'} 20:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:11:00 INFO - Cleaning up... 20:11:00 INFO - Return code: 0 20:11:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:00 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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:11:00 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 20:11:00 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 20:11:00 INFO - Using env: {'DISPLAY': ':0', 20:11:00 INFO - 'HOME': '/home/cltbld', 20:11:00 INFO - 'LANG': 'en_US.UTF-8', 20:11:00 INFO - 'LANGUAGE': 'en_US:en', 20:11:00 INFO - 'LOGNAME': 'cltbld', 20:11:00 INFO - 'MAIL': '/var/mail/cltbld', 20:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:00 INFO - 'MOZ_NO_REMOTE': '1', 20:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:00 INFO - 'NO_EM_RESTART': '1', 20:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:00 INFO - 'PWD': '/builds/slave/test', 20:11:00 INFO - 'SHELL': '/bin/bash', 20:11:00 INFO - 'SHLVL': '1', 20:11:00 INFO - 'TERM': 'linux', 20:11:00 INFO - 'TMOUT': '86400', 20:11:00 INFO - 'USER': 'cltbld', 20:11:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:00 INFO - '_': '/tools/buildbot/bin/python'} 20:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:00 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 20:11:00 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 20:11:00 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 20:11:00 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 20:11:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:01 INFO - Downloading docopt-0.6.1.tar.gz 20:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:02 INFO - Running setup.py install for blobuploader 20:11:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:02 INFO - Running setup.py install for requests 20:11:02 INFO - Running setup.py install for docopt 20:11:02 INFO - Successfully installed blobuploader requests docopt 20:11:02 INFO - Cleaning up... 20:11:02 INFO - Return code: 0 20:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11: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')]} 20:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:02 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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:11:02 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 20:11:02 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 20:11:02 INFO - Using env: {'DISPLAY': ':0', 20:11:02 INFO - 'HOME': '/home/cltbld', 20:11:02 INFO - 'LANG': 'en_US.UTF-8', 20:11:02 INFO - 'LANGUAGE': 'en_US:en', 20:11:02 INFO - 'LOGNAME': 'cltbld', 20:11:02 INFO - 'MAIL': '/var/mail/cltbld', 20:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:02 INFO - 'MOZ_NO_REMOTE': '1', 20:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:02 INFO - 'NO_EM_RESTART': '1', 20:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:02 INFO - 'PWD': '/builds/slave/test', 20:11:02 INFO - 'SHELL': '/bin/bash', 20:11:02 INFO - 'SHLVL': '1', 20:11:02 INFO - 'TERM': 'linux', 20:11:02 INFO - 'TMOUT': '86400', 20:11:02 INFO - 'USER': 'cltbld', 20:11:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:02 INFO - '_': '/tools/buildbot/bin/python'} 20:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:02 INFO - Running setup.py (path:/tmp/pip-MAnUJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:02 INFO - Running setup.py (path:/tmp/pip-t9k1q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:02 INFO - Running setup.py (path:/tmp/pip-WE9CsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:03 INFO - Running setup.py (path:/tmp/pip-gcBDzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:03 INFO - Running setup.py (path:/tmp/pip-sXS2O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:03 INFO - Running setup.py (path:/tmp/pip-TXSmOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:03 INFO - Running setup.py (path:/tmp/pip-uomdh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:03 INFO - Running setup.py (path:/tmp/pip-4OsCU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:03 INFO - Running setup.py (path:/tmp/pip-MFBW4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:03 INFO - Running setup.py (path:/tmp/pip-3_DI9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:03 INFO - Running setup.py (path:/tmp/pip-IJiBCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:03 INFO - Running setup.py (path:/tmp/pip-nriQAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:03 INFO - Running setup.py (path:/tmp/pip-gZT9bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:03 INFO - Running setup.py (path:/tmp/pip-ggemv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:03 INFO - Running setup.py (path:/tmp/pip-fjWezr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:03 INFO - Running setup.py (path:/tmp/pip-hFOn16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:03 INFO - Running setup.py (path:/tmp/pip-P96roA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:04 INFO - Running setup.py install for manifestparser 20:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozcrash 20:11:04 INFO - Running setup.py install for mozdebug 20:11:04 INFO - Running setup.py install for mozdevice 20:11:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozfile 20:11:04 INFO - Running setup.py install for mozhttpd 20:11:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozinfo 20:11:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozInstall 20:11:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:04 INFO - Running setup.py install for mozleak 20:11:04 INFO - Running setup.py install for mozlog 20:11:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Running setup.py install for moznetwork 20:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Running setup.py install for mozprocess 20:11:05 INFO - Running setup.py install for mozprofile 20:11:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Running setup.py install for mozrunner 20:11:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Running setup.py install for mozscreenshot 20:11:05 INFO - Running setup.py install for moztest 20:11:05 INFO - Running setup.py install for mozversion 20:11:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:05 INFO - Cleaning up... 20:11:05 INFO - Return code: 0 20:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:05 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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:11:05 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 20:11:05 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 20:11:05 INFO - Using env: {'DISPLAY': ':0', 20:11:05 INFO - 'HOME': '/home/cltbld', 20:11:05 INFO - 'LANG': 'en_US.UTF-8', 20:11:05 INFO - 'LANGUAGE': 'en_US:en', 20:11:05 INFO - 'LOGNAME': 'cltbld', 20:11:05 INFO - 'MAIL': '/var/mail/cltbld', 20:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:05 INFO - 'MOZ_NO_REMOTE': '1', 20:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:05 INFO - 'NO_EM_RESTART': '1', 20:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:05 INFO - 'PWD': '/builds/slave/test', 20:11:05 INFO - 'SHELL': '/bin/bash', 20:11:05 INFO - 'SHLVL': '1', 20:11:05 INFO - 'TERM': 'linux', 20:11:05 INFO - 'TMOUT': '86400', 20:11:05 INFO - 'USER': 'cltbld', 20:11:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:05 INFO - '_': '/tools/buildbot/bin/python'} 20:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:06 INFO - Running setup.py (path:/tmp/pip-qPo0eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:06 INFO - Running setup.py (path:/tmp/pip-TJ2NbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:06 INFO - Running setup.py (path:/tmp/pip-WM4s__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:06 INFO - Running setup.py (path:/tmp/pip-9ftAQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:06 INFO - Running setup.py (path:/tmp/pip-yfXDgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:06 INFO - Running setup.py (path:/tmp/pip-dePfun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:06 INFO - Running setup.py (path:/tmp/pip-LIS8Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:06 INFO - Running setup.py (path:/tmp/pip-jKKon7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:06 INFO - Running setup.py (path:/tmp/pip-73GkyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:06 INFO - Running setup.py (path:/tmp/pip-CTW7b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:06 INFO - Running setup.py (path:/tmp/pip-b8JvtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:06 INFO - Running setup.py (path:/tmp/pip-yx0f7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:06 INFO - Running setup.py (path:/tmp/pip-IaV0o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:06 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)) 20:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:06 INFO - Running setup.py (path:/tmp/pip-n8PcLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:07 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)) 20:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:07 INFO - Running setup.py (path:/tmp/pip-QUYXNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:07 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)) 20:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:07 INFO - Running setup.py (path:/tmp/pip-qz9esq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:07 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)) 20:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:07 INFO - Running setup.py (path:/tmp/pip-IWGF_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:07 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)) 20:11:07 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)) 20:11:07 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)) 20:11:07 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)) 20:11:07 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)) 20:11:07 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)) 20:11:07 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)) 20:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:08 INFO - Downloading blessings-1.6.tar.gz 20:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:08 INFO - Installing collected packages: blessings 20:11:08 INFO - Running setup.py install for blessings 20:11:08 INFO - Successfully installed blessings 20:11:08 INFO - Cleaning up... 20:11:08 INFO - Return code: 0 20:11:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:08 INFO - Reading from file tmpfile_stdout 20:11:08 INFO - Current package versions: 20:11:08 INFO - argparse == 1.2.1 20:11:08 INFO - blessings == 1.6 20:11:08 INFO - blobuploader == 1.2.4 20:11:08 INFO - docopt == 0.6.1 20:11:08 INFO - functools32 == 3.2.3-2 20:11:08 INFO - jsonschema == 2.5.1 20:11:08 INFO - manifestparser == 1.1 20:11:08 INFO - mozInstall == 1.13 20:11:08 INFO - mozcrash == 1.0 20:11:08 INFO - mozdebug == 0.1 20:11:08 INFO - mozdevice == 0.51 20:11:08 INFO - mozfile == 1.2 20:11:08 INFO - mozhttpd == 0.7 20:11:08 INFO - mozinfo == 0.10 20:11:08 INFO - mozleak == 0.1 20:11:08 INFO - mozlog == 3.5 20:11:08 INFO - moznetwork == 0.27 20:11:08 INFO - mozprocess == 0.25 20:11:08 INFO - mozprofile == 0.28 20:11:08 INFO - mozrunner == 6.13 20:11:08 INFO - mozscreenshot == 0.1 20:11:08 INFO - mozsystemmonitor == 0.3 20:11:08 INFO - moztest == 0.8 20:11:08 INFO - mozversion == 1.4 20:11:08 INFO - psutil == 3.1.1 20:11:08 INFO - requests == 1.2.3 20:11:08 INFO - wsgiref == 0.1.2 20:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11: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')]} 20:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:08 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 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:11:08 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 20:11:08 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 20:11:08 INFO - Using env: {'DISPLAY': ':0', 20:11:08 INFO - 'HOME': '/home/cltbld', 20:11:08 INFO - 'LANG': 'en_US.UTF-8', 20:11:08 INFO - 'LANGUAGE': 'en_US:en', 20:11:08 INFO - 'LOGNAME': 'cltbld', 20:11:08 INFO - 'MAIL': '/var/mail/cltbld', 20:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:08 INFO - 'MOZ_NO_REMOTE': '1', 20:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:08 INFO - 'NO_EM_RESTART': '1', 20:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:08 INFO - 'PWD': '/builds/slave/test', 20:11:08 INFO - 'SHELL': '/bin/bash', 20:11:08 INFO - 'SHLVL': '1', 20:11:08 INFO - 'TERM': 'linux', 20:11:08 INFO - 'TMOUT': '86400', 20:11:08 INFO - 'USER': 'cltbld', 20:11:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:08 INFO - '_': '/tools/buildbot/bin/python'} 20:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 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)) 20:11:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:11:10 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)) 20:11:10 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)) 20:11:10 INFO - Installing collected packages: simplejson 20:11:10 INFO - Running setup.py install for simplejson 20:11:10 INFO - building 'simplejson._speedups' extension 20:11:10 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 20:11:11 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 20:11:11 INFO - Successfully installed simplejson 20:11:11 INFO - Cleaning up... 20:11:11 INFO - Return code: 0 20:11:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11: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')]} 20:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', '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 20:11: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'] in /builds/slave/test/build 20:11: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 20:11:11 INFO - Using env: {'DISPLAY': ':0', 20:11:11 INFO - 'HOME': '/home/cltbld', 20:11:11 INFO - 'LANG': 'en_US.UTF-8', 20:11:11 INFO - 'LANGUAGE': 'en_US:en', 20:11:11 INFO - 'LOGNAME': 'cltbld', 20:11:11 INFO - 'MAIL': '/var/mail/cltbld', 20:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:11 INFO - 'MOZ_NO_REMOTE': '1', 20:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:11 INFO - 'NO_EM_RESTART': '1', 20:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:11 INFO - 'PWD': '/builds/slave/test', 20:11:11 INFO - 'SHELL': '/bin/bash', 20:11:11 INFO - 'SHLVL': '1', 20:11:11 INFO - 'TERM': 'linux', 20:11:11 INFO - 'TMOUT': '86400', 20:11:11 INFO - 'USER': 'cltbld', 20:11:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:11 INFO - '_': '/tools/buildbot/bin/python'} 20:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:11:11 INFO - Cleaning up... 20:11:11 INFO - Return code: 0 20:11:11 INFO - Running post-action listener: _resource_record_post_action 20:11:11 INFO - Running post-action listener: _start_resource_monitoring 20:11:11 INFO - Starting resource monitoring. 20:11:11 INFO - [mozharness: 2017-09-21 03:11:11.560079Z] Finished create-virtualenv step (success) 20:11:11 INFO - [mozharness: 2017-09-21 03:11:11.560880Z] Running install step. 20:11:11 INFO - Running pre-action listener: _resource_record_pre_action 20:11:11 INFO - Running main action method: install 20:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:11 INFO - Reading from file tmpfile_stdout 20:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:11 INFO - Reading from file tmpfile_stdout 20:11:11 INFO - Output received: 20:11:11 INFO - Usage: mozinstall [options] installer 20:11:11 INFO - Options: 20:11:11 INFO - -h, --help show this help message and exit 20:11:11 INFO - -d DEST, --destination=DEST 20:11:11 INFO - Directory to install application into. [default: 20:11:11 INFO - "/builds/slave/test"] 20:11:11 INFO - --app=APP Application being installed. [default: firefox] 20:11:11 INFO - mkdir: /builds/slave/test/build/application 20:11:11 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'] 20:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:11:29 INFO - Reading from file tmpfile_stdout 20:11:29 INFO - Output received: 20:11:29 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:29 INFO - Running post-action listener: _resource_record_post_action 20:11:29 INFO - [mozharness: 2017-09-21 03:11:29.678376Z] Finished install step (success) 20:11:29 INFO - [mozharness: 2017-09-21 03:11:29.678627Z] Running setup-mitmproxy step. 20:11:29 INFO - Running pre-action listener: _resource_record_pre_action 20:11:29 INFO - Running main action method: setup_mitmproxy 20:11:29 INFO - Skipping: mitmproxy is not required 20:11:29 INFO - Running post-action listener: _resource_record_post_action 20:11:29 INFO - [mozharness: 2017-09-21 03:11:29.679745Z] Finished setup-mitmproxy step (success) 20:11:29 INFO - [mozharness: 2017-09-21 03:11:29.680020Z] Running run-tests step. 20:11:29 INFO - Running pre-action listener: _resource_record_pre_action 20:11:29 INFO - Running pre-action listener: _set_gcov_prefix 20:11:29 INFO - Running main action method: run_tests 20:11:29 WARNING - Try message not found. 20:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:29 INFO - Python 2.7.3 20:11:29 INFO - Return code: 0 20:11:29 INFO - grabbing minidump binary from tooltool 20:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26de090>, '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 0x26ded80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d8f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:11:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:11:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:11:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:29 INFO - Return code: 0 20:11:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:29 INFO - ENV: RUST_BACKTRACE is now full 20:11:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 20:11:29 INFO - Using env: {'DISPLAY': ':0', 20:11:29 INFO - 'HOME': '/home/cltbld', 20:11:29 INFO - 'LANG': 'en_US.UTF-8', 20:11:29 INFO - 'LANGUAGE': 'en_US:en', 20:11:29 INFO - 'LOGNAME': 'cltbld', 20:11:29 INFO - 'MAIL': '/var/mail/cltbld', 20:11:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:29 INFO - 'MOZ_ACCELERATED': '1', 20:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:29 INFO - 'MOZ_NO_REMOTE': '1', 20:11:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:29 INFO - 'MOZ_WEBRENDER': '1', 20:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:29 INFO - 'NO_EM_RESTART': '1', 20:11:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:29 INFO - 'PWD': '/builds/slave/test', 20:11:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:29 INFO - 'RUST_BACKTRACE': 'full', 20:11:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:11:29 INFO - 'SHELL': '/bin/bash', 20:11:29 INFO - 'SHLVL': '1', 20:11:29 INFO - 'TERM': 'linux', 20:11:29 INFO - 'TMOUT': '86400', 20:11:29 INFO - 'USER': 'cltbld', 20:11:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:29 INFO - '_': '/tools/buildbot/bin/python'} 20:11:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 20:11:30 INFO - mozversion application_buildid: 20170921022004 20:11:30 INFO - mozversion application_changeset: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf 20:11:30 INFO - mozversion application_display_name: Nightly 20:11:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:30 INFO - mozversion application_name: Firefox 20:11:30 INFO - mozversion application_remotingname: firefox 20:11:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:11:30 INFO - mozversion application_vendor: Mozilla 20:11:30 INFO - mozversion application_version: 57.0a1 20:11:30 INFO - mozversion platform_buildid: 20170921022004 20:11:30 INFO - mozversion platform_changeset: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf 20:11:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:11:30 INFO - mozversion platform_version: 57.0a1 20:11:30 INFO - using testdate: 1505963490 20:11:30 INFO - actual date: 1505963490 20:11:30 INFO - starting webserver on 'localhost:35298' 20:11:30 INFO - SUITE-START | Running 2 tests 20:11:30 INFO - TEST-START | dromaeo_css 20:11:30 INFO - Initialising browser for dromaeo_css test... 20:11:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35298/getInfo.html -profile /tmp/tmpUNhEIV/profile 20:11:30 INFO - TEST-INFO | started process 3575 (/builds/slave/test/build/application/firefox/firefox http://localhost:35298/getInfo.html) 20:11:41 INFO - TEST-INFO | 3575: exit 0 20:11:41 INFO - Browser initialized. 20:11:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:41 INFO - Using env: {'DISPLAY': ':0', 20:11:41 INFO - 'HOME': '/home/cltbld', 20:11:41 INFO - 'JSGC_DISABLE_POISONING': '1', 20:11:41 INFO - 'LANG': 'en_US.UTF-8', 20:11:41 INFO - 'LANGUAGE': 'en_US:en', 20:11:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:11:41 INFO - 'LOGNAME': 'cltbld', 20:11:41 INFO - 'MAIL': '/var/mail/cltbld', 20:11:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:41 INFO - 'MOZ_ACCELERATED': '1', 20:11:41 INFO - 'MOZ_CRASHREPORTER': '1', 20:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:11:41 INFO - 'MOZ_NO_REMOTE': '1', 20:11:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:41 INFO - 'MOZ_WEBRENDER': '1', 20:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:41 INFO - 'NO_EM_RESTART': '1', 20:11:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:41 INFO - 'PWD': '/builds/slave/test', 20:11:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:41 INFO - 'RUST_BACKTRACE': 'full', 20:11:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:11:41 INFO - 'SHELL': '/bin/bash', 20:11:41 INFO - 'SHLVL': '1', 20:11:41 INFO - 'TERM': 'linux', 20:11:41 INFO - 'TMOUT': '86400', 20:11:41 INFO - 'USER': 'cltbld', 20:11:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:41 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUNhEIV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:42 INFO - PID 3819 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:11:42 INFO - PID 3819 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:11:42 INFO - PID 3819 | 20:11:42 INFO - PID 3819 | (/builds/slave/test/build/application/firefox/firefox:3878): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:11:42 INFO - PID 3819 | 20:11:53 INFO - PID 3819 | RSS: Main: 207482880 20:11:53 INFO - PID 3819 | 20:14:50 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35298/tests/dromaeo/cssquery-ext.html) 20:14:51 INFO - PID 3819 | RSS: Main: 208429056 20:14:51 INFO - PID 3819 | 20:17:53 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-ext.html (next: http://localhost:35298/tests/dromaeo/cssquery-jquery.html) 20:17:54 INFO - PID 3819 | RSS: Main: 207679488 20:17:54 INFO - PID 3819 | 20:20:56 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35298/tests/dromaeo/cssquery-mootools.html) 20:20:57 INFO - PID 3819 | RSS: Main: 208953344 20:20:57 INFO - PID 3819 | 20:23:59 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35298/tests/dromaeo/cssquery-prototype.html) 20:23:59 INFO - PID 3819 | RSS: Main: 207298560 20:23:59 INFO - PID 3819 | 20:27:03 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35298/tests/dromaeo/cssquery-yui.html) 20:27:03 INFO - PID 3819 | RSS: Main: 210935808 20:27:03 INFO - PID 3819 | 20:30:05 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:35298/tests/dromaeo/cssquery-yui.html (next: http://localhost:35298/tests/dromaeo/cssquery-dojo.html) 20:30:06 INFO - PID 3819 | RSS: Main: 211030016 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | __start_tp_report 20:30:06 INFO - PID 3819 | _x_x_mozilla_page_load 20:30:06 INFO - PID 3819 | _x_x_mozilla_page_load_details 20:30:06 INFO - PID 3819 | |i|pagename|runs| 20:30:06 INFO - PID 3819 | |0;dojo.html;3090.830004349761;3143.827089510077;3156.873725050998;3165.0504848545447;3165.810051396916;6354.364563543649;6364.713587888545;6376.33048529904;6405.967970160143;6408.359164083589;6229.096780966757;6286.968565157168;6306.747730090802;6323.462505687011;6348.746050157988;5867.413258674141;5871.559633027518;5874.206982057421;5905.645661260338;5947.970260148693;5814.883702325951;5894.734736936848;5938.8218353449465;5969.343372229051;5982.8803423931495;1137.0909503694097;5730.914036289438;5765.452282033221;5945.672987985659;5964.075568286922;5816.88366232673;5874.823755287348;5880.764769409218;5906.438888305647;5917.644941303535;5804.129380592903;5804.52537814295;5863.560232982501;5867.266591676041;5897.14491398749;6291.8741625167695;6323.20959880015;6342.968285158545;6397.904031439532;6450.387213214737;6720.596764194164;6761.628110453923;6771.593704377704;6832.760853370158;6887.862242755167;6612.0412540181405;6839.076724642159;6849.554778939353;6923.792286231421;6931.41083007945;6270.749170033193;6303.401176888188;6404.391582799627;6424.71088801005;6435.646039467827;6974.930250697428;7048.471364647672;7054.365107140382;7060.964695176492;7076.540024898365;6611.140551728245;6651.16860392451;6679.833004174934;6752.358525940028;6754.358335958076;6603.306652801387;6683.832904177337;6703.530752847254;6704.363085506869;6719.857624203897;6622.602643841385;6661.100751398596;6661.367170118831;6689.163854518185;6696.397324240745;6637.46900247979;6700.195976482756;6715.227748808852;6807.5575087619145;6834.6582670866255;5232.2413250078525;5296.3379577552805;5311;5382.946170538323;5384.138537833927;4639.420072490939;4641.187792136363;4672.43930728308;4675.555822196886;4689.320048592935;5759.6832174229985;5779.8555036124435;5784.958707432618;5837.357890632027;5848.883022339614;6726.159230096238;6778.186617605918;6784.118064651662;6830.248672646005;6859.176898772179;5739.139129130664;5797.101449275369;5798.10129429939;5799.565032622486;5800.332961709373;5783.797567085216;5785.652860828363;5812.157237200582;5820.767169313265;5867.735951882176;6403.743850245938;6481.449076828428;6483.448906842971;6580.736770529221;6581.111549940792;6674.065630811788;6694.665266736741;6757.189137303555;6792.252852186256;6797.6941037654415;6361.268454127649;6485;6523.151990241238;6558.508111891722;6620.801375958729;6711.3288671132495;6712.496562757715;6775.390214880685;6792.96603516999;6798.626075565891;6848.897266541106;6854.9657251713425;6894.965525172342;6932.792016239521;6934.895976560457;6501.187351581052;6519.185101862267;6539.11721917554;6582.868342633216;6614.173228346457;6449.903251451326;6472.838179045561;6488.935110649022;6528.869422611426;6535.542512024303;6381.8085457436355;6439;6443.387878151568;6443.96778016107;6460.967695161494;6625.734970601122;6642.568233064835;6686.13080299558;6723.226828914738;6749.223839258548;6346.174997250328;6413.583117097561;6418.614883107029;6467.256265529336;6496.9025464617125 20:30:06 INFO - PID 3819 | |1;ext.html;879.3273146043277;882.519027130214;888.493558671557;893.5576889439726;894.2577660541747;37460.81269593655;40906.38640420392;40922.386164207484;41115;41135.38296925545;37465.62534374656;37612.62387376125;37638.247235055285;37644.81177594115;37665.62334376655;7162.319579639939;7392.963035184816;7397.112346518398;7399.223081576438;7401.148867880182;7273.163586187603;7292.4530660200435;7312.963435182816;7328.413726901862;7347.63261836906;7278.126624805031;7279.053723016001;7306.196318404971;7353.117625884901;7365.300296471826;7308.049953506037;7904.328132108778;8107.675692972274;8119;8125.268725814705;7947.562884041376;7950.045994480699;7983.920160798376;8010.879836802453;8040.678372865078;36653;37003;37083;37213.255734885424;37805.62194378076;3560.0565850049757;3608.079939615381;3622.022054045393;3635.0912271932016;3637.1270894985014;31964.360712785845;32034.19914502156;32043.679563204303;32107.83946080278;32224.355512889844;5140.922886156711;5151.356080489939;5178.766955487012;5212.530872221519;5244.895102097937;187130;190727;190769.04615476972;190815;191080;41285.79357103195;42653;47840.5215947843;47921.76039119852;48240.758796205795;50369.49630503648;50621.240681389805;50641.746791266545;50707.23939140916;50865;16109.677806443806;16252.268647910636;16265.59336016609;16269.91865040691;16273.349066037463;13286.3356832158;13305.66735831612;13318.733625327439;13333.733325333438;13335.133216340906;14088.225147616979;14171.362288697033;14221.217833019284;14237.85762142386;14386.712265754626;5840.707964601753;5907.527397808165;5933.525317974551;5976.432238937294;6025.698715064229;985.3250523391499;985.9852102218473;1007.6422869881234;1012.5392946209457;1018.7809620931536;21960.34118976433;22200.333989980325;22239.777602224094;22380.776192238194;22548.774512254666;1098.242212873115;1105.3257512917114;1115.369816053927;1119.5633702855894;1123.1127409346525;11882.88117118835;12118.81821772674;12195.878041219474;12343.506259749689;12395.380230988414;228703;230198;230744;231430;231801;52535.474645253824;52671.73664131655;52948.94102118013;52983;53042.46957530452;1379.048456564967;1460.7297649934796;1462.641652795072;1463.5682473670292;1464.736347457468;22270.888645556668;22646.886765566065;22678.433039174153;22756.886215568815;23016.539669206857;36067.639323606425;36551.45172822357;36578.45132323071;36621.816890915376;36752.63247367492;189604;192747;192781;193264;193457;30897.227569310948;31551.84224078865;34000.65999339975;34173.316533669684;34255.486167708004;43705.68882933517;43840.561594384926;43952.34071488994;43993.340099899164;44312.11375772531;31730.365392692478;32111.518327224643;32308.83845580757;32381.676183238807;32603.836980815893;31248.687513125486;31445.371092578476;31819.522707159875;31861.522077169324;31971.840140799148;35661.465078023335;35715.46426803652;35740.64259357477;35991;36006.279874401844;30993.380132397677;31183;31304.217394564406;31483;31686;22634.773652263924;22725.545489090455;22827.657585136567;22942.885285573466;23221.3033608992 20:30:06 INFO - PID 3819 | |2;jquery.html;557.9781962338949;561.5367321959385;592.4608606168385;607.7234858139547;609.9603525770824;21913.67129493057;22624.66063009054;22651.886740566315;22690.65964010539;22746.976386062626;23577.29268121959;23955.281341559737;24417.389565260833;25188.992440302365;25324.493510129785;6520.70656820443;6634.038064480647;6667.766628168015;6699.397054265115;6734.8989765153565;6572.44134248587;6585.37438943302;6631.403173714365;6639.634820084893;6681.699323530428;6353.428191462767;6629.071929929813;6637.435817955479;6650.268470468244;6693.129893113888;6676.966615166917;6722.495812814059;6723.697433615474;6727.360900714449;6730.293319201512;6176.907346389808;6226.501879849601;6232.532560058014;6238.282597501255;6241.063840423927;27250.182494524997;28384.716152838413;28929.276768080967;29222.415551688846;29286.707132928612;2003.7094621279832;2066.524699319165;2067.255787916364;2070.265055905162;2073.9377818665466;19024.80975190244;19461.708074378897;19534.80465195344;19538;19554.804451955442;2445.303088619735;2446.9143579974616;2499.7500249974855;2508.28513873547;2509.2973967289004;113889.86110138876;120630;120704;123857.38071309676;134559.32720336335;15005.445806728758;15112.697746045018;15234.238288085773;15263.160526170945;15790.447334343473;23812.64281035786;23843.284701458982;23898.283051508482;23947;24016.27951161468;10246.795064098676;10408.427536485415;10478.580856765797;10499.737506562396;10619.628313009007;9716.514174291256;9761.853572196424;9774.951125244328;9889.258305627107;9903.207743380512;9058.139476749699;9139.680111196076;9258.166764991183;9335.953320233355;9432.764180895532;2696.7303269673266;2710.430809529981;2716.9079808547704;2717.945641087167;2800.747932686068;927.4249965021595;960.3805545423303;965.3483898368573;969.6896992962185;986.5067466266867;19359.3224237151;19422.320218792276;19662.606747864964;19783;19928.402147935583;1018.872640919885;1023.3143793658118;1038.8597539332245;1039.8024375368657;1044.1698849414734;10754.56981720738;10879.184061195441;11049.779004420026;11112.499937502671;11141.240801460892;492050;495482.21371528413;518178;519385;520579;108214.45892770485;108488.74533764;110220;111075.44462277637;115271.42364288124;999.4552968632113;1008.8587597736323;1121.556984990924;1170.2861254634665;1179.4044007776017;20406.693899591814;20646.58706825825;20862.895685521475;20887.8955605221;21123.155073796876;55093.44906551044;56731.71634141803;56901.715491423936;57035.71482142563;58205.70897145487;69784;69874.65062674654;70252;71236;71282;14938.477153300017;15126.39494420211;15175.089494630358;15234.542963711106;15292.158931258888;23714.170004049774;23730.169444070067;23902.402439938443;24225.63661545043;24361.75638243595;18997.62004759925;19099;19217.61564768725;19258.8074119257;19474.707879381538;16811.327546898476;17126.571835704206;17416.738748918524;17553.561160970567;17695.46913592594;18572.164252608396;18987.14557844928;19182.904085479484;19380.709289360388;19561.119749611586;14866.10803351759;14882.181480018702;14904.850951490347;14957.17735524513;15218.239088045331;18309.54226144357;18413.81586184121;18428.539286517946;18536.536586585444;18761.155747991645 20:30:06 INFO - PID 3819 | |3;mootools.html;1290.95481658142;1333.3799783100856;1344.8367162404522;1347.528365072225;1350.5273154395968;15369.385224591017;15796.842031579696;15896.12571308579;15913.283902224399;15922.442714504994;15643.452479163232;15667.216639168053;15798.289076991534;15805.60485987851;15834.366625334973;2791.0649932272613;2841.6732075811287;2870.124611993341;2874.338902052529;2875.8274503529856;2768.8754006069676;2829.264391258267;2837.290677330667;2841.77265818734;2853;2777.2501424615343;2798.916032519028;2803.579463080534;2803.8177518461234;2900.9129726108144;2875.683674795771;2891.667458242308;2892.392597554516;2902.3179552805072;2905.970940290602;2701.0546308791963;2719.0891051497774;2730.713275106125;2752.7935404844516;2773.057160565397;14741.484048058373;15050.473233436776;15248.771268430983;15268.083914965138;15529.922350388175;8165.591720413956;8409.32725381968;8433.95783021081;8437.114103019156;8453.492790432594;5562.16567514872;5783.479486846204;5906.852328691817;5912.201852749867;5932.495737862287;1999.720039194514;2021.8980655542764;2023.827974622159;2045.815876571101;2064.5870825834895;26761.46477070467;26997.570218680412;27009.32476688079;27079.187624371105;27091.729082709116;6871.14110736158;7010.193827709777;7036.155661320674;7255;7277.2722727726805;17519.21163547618;17587.208575613873;17644.735328970077;17754.644907101785;17762.555936101442;8116.959415202886;8267.090620031791;8294.917050829536;8326.125756795449;8326.25063744266;7459.104907411145;7584.696612135564;7642.69429222836;7681.155072941972;7697.499662521918;5420.864478387993;5522.199281104217;5605.159226116034;5629.211910332557;5670.149477578314;1668.416054380957;1691.2727527163438;1692.8645708343304;1694.6102396448887;1704.6164612962232;830.1283652165203;846.8856704344958;868.2880038368603;877.3025444771422;880.7313769300297;7320.414366850639;8231.670733170726;8454.535000575028;8511.489310641382;8533.871991920127;715.6314498033516;734.3757805864972;736.348331726426;742.6769355330448;747.9027726395534;4639.9536004640195;4878.317035615017;4921.680090794159;4947.183714687037;5052.823151189691;21695.240666576596;22021.33935981923;22466.550668986856;22558.21046263406;22562.887185564294;21330.14679412837;21689.78310216909;22147.778522214892;22150.22474213427;22401.10395584191;10503.579856805794;10545.261831671864;10713.464326783629;11033.668989930315;11035.779284414266;8366.74899752984;8501.489910605384;8565.229129378386;8566.91433085661;8658.870116948125;18367.632647347247;18890.149943252312;18999;19143.61712765709;19240.134193961585;18285.26858925681;19173.712394313818;19432.70850937209;19884.10521526506;19987.100580473623;11384.203105782846;11634.476448559666;11649.650510484698;11673.357965311989;11703.590374336858;12626.873731262569;13138.474461021453;13461.528846490326;13467.932660336635;13480.5281815136;11846.289222646325;11919.225250359046;11950.581729639422;11959.701007474883;12076;11357.148213883827;11538.480768365276;11559.595414160463;11669.416529173337;11731.648050558497;9795.412275263507;9828.705138845846;9917.404955702681;9952.203823694232;9992.500374981077;6814.184056928136;6953.478489113236;7015.052967849275;7024.473164512784;7099.006139140628;7492.887606685795;7564.773056808304;7663.655135519027;7701.345385642283;7722.7297044603165 20:30:06 INFO - PID 3819 | |4;prototype.html;503.9143345631242;517.4024002277368;533.2454576773865;540.2436588775713;543.6004536665553;6203.480147363896;6255.781047663333;6277.435030847223;6295.968520157398;6402.135711678922;6219.906701399483;6261.843453913654;6275.748970041204;6285.6857157142185;6304.33804450533;5192.416313024526;5204.531592156714;5221.947780522203;5265.973670131644;5267.601552703497;5190.013897359489;5207.4792520748;5238.816641417551;5262;5273.209018647195;4744.57298843104;4989.126902791997;4991.076650819592;4998.750062496879;5028.547430731233;5000.349954505909;5019.071471777733;5019.749012549394;5046.142155833517;5073.137566613685;4494.393256910308;4519.299508576176;4521.796519156645;4541.227991241497;4541.6593755468475;5824.650520968713;5997.8800423991715;6071.150038994544;6084.908726369108;6142.662153581551;5582.330120385539;5673.489385955242;5726.284214473191;5727.742251598688;5744.971275143597;6498.675066246668;6541.869162616721;6581.7367305307735;6586.571872828251;6622.165818952192;4650.7442090685;4809.446913604946;4835.492273311322;4847.842709994054;4869.2939523768855;6634;6709.429698475636;6724.78082232862;6731.93268067318;6849.589024658537;4922.4339200992345;4993.850184494471;5051.595872330205;5053.545180933734;5069.746512674352;5049.974750126225;5087.364079490064;5097.439281679012;5107.310513080761;5149.433562308143;5641.548676105902;5719.113537401709;5724.681503990891;5739.713014349266;5773.509251713567;6597.47220222381;6619.437347825488;6622.145799176238;6626.503012274099;6642.202935647657;1749.1691446562781;1768.2308195934809;1773.8137495563037;1788.2936240185054;1794.5065107095654;1161.3902701081831;1233.1984210263402;1233.481937586216;1236.7773800715956;1237.1401875696486;5642.996736158687;5645.774169033275;5652.123920792284;5675.886482270332;5719.742611582489;6639.435647969976;6647.501437392215;6688.765893193715;6720.428763555153;6751.392374686204;5627.71861406928;5632.831015069554;5647.802326918538;5660.150977353348;5688.971555142198;3494.423420135649;3516.542849429558;3521.489384039351;3536.876209332661;3557.7509574329547;6205.503559715212;6307.5269354798575;6319.810405687745;6395.2645445773405;6462.903056454063;6300.59046161998;6588;6691.7323307068145;6756.898646520306;6761.763338283136;6342.492600592034;6343.777967771106;6360.759651867934;6399.936000639934;6410.423061924449;6524.67376631176;6608.6034837907955;6615.717577435777;6621.370969757865;6636.739019586264;6466.865934241595;6549.214094308523;6562.934370656423;6645.704087702851;6734.292899245705;6343.492520598434;6353.9046914295395;6450.903236451363;6493.512986525935;6509.02364645307;4896.579991802338;4940.333055037668;4998.4251811042195;5038.193888977746;5071.39143302806;6291.213598300213;6545.985372267306;6586.951961401254;6635.270120286668;6645.534812563074;6204.751809927552;6480.481561474976;6513.576617519846;6522.412982831568;6600.438962688033;6451.3226111257645;6504.528279253853;6531.706073226621;6536.738530458729;6584.572002819801;6343.016832390987;6395.744170233139;6412.9358706414205;6427.421532062137;6493.155889734304;6553.311902250195;6560.048792925095;6572.934270657232;6599.340065993362;6622.437092847162;6296.590721603081;6329.90505142414;6340.463814474063;6355.523335749745;6387.425131738166 20:30:06 INFO - PID 3819 | |5;yui.html;908.3596064774334;912.4844462878473;926.6525053105086;931.9114684105008;941.1764705882351;19152.13815378308;19941.900290498565;20001.799982000175;20002.29991950282;20014.39956801295;18201.45395638133;18321.534277257822;18431.447056588324;18478.538036549093;18549.165287562057;945.4658118163233;961.8749562556858;962.1100482054072;966.9274804389664;967.2842096848317;956.1060408518058;962.1725316228038;965.8213230552335;969.1810420194925;969.4764826993451;938.4650749072997;973.5229737428645;1016.11090295991;1020.1583693452894;1025.5077562769875;1014.6296601740312;1015.2639336481066;1018.4347687033693;1021.8722659667542;1023.2325755683238;736.7384578474617;742.8365759532949;742.8440027594212;746.518495570354;746.8917007033949;20130.194792208295;20680.79319206804;20858.061387237613;20889.268875589434;20904.059317330757;21623.135074596998;22267.888660556757;22354.32937011892;22415;22514.77485225143;17210.483685489457;17401.129943502776;17485.30058797659;17494.212760425686;17502.124893755263;3637.381645120336;3719.3677074897064;3733.2346868891814;3753.3056384568667;3786.1670432504807;137392.31303843416;137875.31062344724;141633;141748;142076;16649.91675041617;16685.91657041707;16735;16745;16884.409045683587;31450.21374465657;31669.366612667618;31854.522182167286;31937.361252775278;31975.20061998422;8138.430309878252;8203.548804815673;8220.424570280024;8309.709160179365;8402.369822263354;4328.177646247203;4342.131573685276;4348.717333373321;4352.825886964486;4370.191514569815;5452.318460192476;5533.08704063833;5576.247206627135;5604.747786349624;5622.156676498558;1002.3334482569155;1009.5810238750983;1011.9190464762802;1014.2038499777639;1021.9693409197736;659.7130248341987;666.8966310221923;680.496432639843;684.9965750171317;685.3146853146853;11064.889351106547;11124.38815865119;11240.775184496264;11315.03822175108;11397.316161030365;644.0532417346493;658.236445722959;658.5949640970769;661.5270081891471;668.1214203322616;5152.278680984665;5206.739663016834;5267.236250743697;5280.709560974184;5283.101872681654;116550;116562;120279.36368272068;120648;121115;98996;100033;102167.48916255371;103484;104335.4783226079;91000.54499727458;91133.54433227792;91897.54051229701;92343.07656923479;92473;9848.556814943202;9970;10089.445080520642;10164.542595583069;10378.688639340831;41853.58146418619;43117.568824311355;43129.13741725211;44060.33909491424;44134.55865441304;53049;54133.45866541284;55752.72123639356;55834.720826395605;55972.72013639906;15183.164925928739;15766;15810.7628385572;15844.366225350857;15881;17135.742963855802;17312.826871731122;17464.12679366052;17508.124593770004;17652.823471765118;14022.368993395527;14114.223717695626;14184;14188.858111418755;14455.349509272319;14301.213433261271;14494.05788623736;14494.202818845064;14564.635884102981;14707.044042137228;13624.52314169039;13682.452701891812;13857.099288546213;13886.583402497941;13979.881609471422;11383.829242561202;11580.826287605862;11702.824457632973;11980.64058078259;12001.219920705125;11372.829407559058;11514.94242528782;11520.193586448868;11546.769064618493;11649.068074553847 20:30:06 INFO - PID 3819 | __end_tp_report 20:30:06 INFO - PID 3819 | __start_cc_report 20:30:06 INFO - PID 3819 | _x_x_mozilla_cycle_collect,281 20:30:06 INFO - PID 3819 | __end_cc_report 20:30:06 INFO - PID 3819 | __startTimestamp1505964606187__endTimestamp 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | ------- Summary: start ------- 20:30:06 INFO - PID 3819 | Number of tests: 6 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#0] dojo.html Cycles:165 Average:6201.17 Median:6443.97 stddev:844.38 (13.1%) stddev-sans-first:810.95 20:30:06 INFO - PID 3819 | Values: 3090.8 3143.8 3156.9 3165.1 3165.8 6354.4 6364.7 6376.3 6406.0 6408.4 6229.1 6287.0 6306.7 6323.5 6348.7 5867.4 5871.6 5874.2 5905.6 5948.0 5814.9 5894.7 5938.8 5969.3 5982.9 1137.1 5730.9 5765.5 5945.7 5964.1 5816.9 5874.8 5880.8 5906.4 5917.6 5804.1 5804.5 5863.6 5867.3 5897.1 6291.9 6323.2 6343.0 6397.9 6450.4 6720.6 6761.6 6771.6 6832.8 6887.9 6612.0 6839.1 6849.6 6923.8 6931.4 6270.7 6303.4 6404.4 6424.7 6435.6 6974.9 7048.5 7054.4 7061.0 7076.5 6611.1 6651.2 6679.8 6752.4 6754.4 6603.3 6683.8 6703.5 6704.4 6719.9 6622.6 6661.1 6661.4 6689.2 6696.4 6637.5 6700.2 6715.2 6807.6 6834.7 5232.2 5296.3 5311.0 5382.9 5384.1 4639.4 4641.2 4672.4 4675.6 4689.3 5759.7 5779.9 5785.0 5837.4 5848.9 6726.2 6778.2 6784.1 6830.2 6859.2 5739.1 5797.1 5798.1 5799.6 5800.3 5783.8 5785.7 5812.2 5820.8 5867.7 6403.7 6481.4 6483.4 6580.7 6581.1 6674.1 6694.7 6757.2 6792.3 6797.7 6361.3 6485.0 6523.2 6558.5 6620.8 6711.3 6712.5 6775.4 6793.0 6798.6 6848.9 6855.0 6895.0 6932.8 6934.9 6501.2 6519.2 6539.1 6582.9 6614.2 6449.9 6472.8 6488.9 6528.9 6535.5 6381.8 6439.0 6443.4 6444.0 6461.0 6625.7 6642.6 6686.1 6723.2 6749.2 6346.2 6413.6 6418.6 6467.3 6496.9 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#1] ext.html Cycles:180 Average:37071.81 Median:35728.05 stddev:53138.68 (148.7%) stddev-sans-first:53218.26 20:30:06 INFO - PID 3819 | Values: 879.3 882.5 888.5 893.6 894.3 37460.8 40906.4 40922.4 41115.0 41135.4 37465.6 37612.6 37638.2 37644.8 37665.6 7162.3 7393.0 7397.1 7399.2 7401.1 7273.2 7292.5 7313.0 7328.4 7347.6 7278.1 7279.1 7306.2 7353.1 7365.3 7308.0 7904.3 8107.7 8119.0 8125.3 7947.6 7950.0 7983.9 8010.9 8040.7 36653.0 37003.0 37083.0 37213.3 37805.6 3560.1 3608.1 3622.0 3635.1 3637.1 31964.4 32034.2 32043.7 32107.8 32224.4 5140.9 5151.4 5178.8 5212.5 5244.9 187130.0 190727.0 190769.0 190815.0 191080.0 41285.8 42653.0 47840.5 47921.8 48240.8 50369.5 50621.2 50641.7 50707.2 50865.0 16109.7 16252.3 16265.6 16269.9 16273.3 13286.3 13305.7 13318.7 13333.7 13335.1 14088.2 14171.4 14221.2 14237.9 14386.7 5840.7 5907.5 5933.5 5976.4 6025.7 985.3 986.0 1007.6 1012.5 1018.8 21960.3 22200.3 22239.8 22380.8 22548.8 1098.2 1105.3 1115.4 1119.6 1123.1 11882.9 12118.8 12195.9 12343.5 12395.4 228703.0 230198.0 230744.0 231430.0 231801.0 52535.5 52671.7 52948.9 52983.0 53042.5 1379.0 1460.7 1462.6 1463.6 1464.7 22270.9 22646.9 22678.4 22756.9 23016.5 36067.6 36551.5 36578.5 36621.8 36752.6 189604.0 192747.0 192781.0 193264.0 193457.0 30897.2 31551.8 34000.7 34173.3 34255.5 43705.7 43840.6 43952.3 43993.3 44312.1 31730.4 32111.5 32308.8 32381.7 32603.8 31248.7 31445.4 31819.5 31861.5 31971.8 35661.5 35715.5 35740.6 35991.0 36006.3 30993.4 31183.0 31304.2 31483.0 31686.0 22634.8 22725.5 22827.7 22942.9 23221.3 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#2] jquery.html Cycles:180 Average:34915.48 Median:23722.17 stddev:84896.56 (357.9%) stddev-sans-first:85095.53 20:30:06 INFO - PID 3819 | Values: 558.0 561.5 592.5 607.7 610.0 21913.7 22624.7 22651.9 22690.7 22747.0 23577.3 23955.3 24417.4 25189.0 25324.5 6520.7 6634.0 6667.8 6699.4 6734.9 6572.4 6585.4 6631.4 6639.6 6681.7 6353.4 6629.1 6637.4 6650.3 6693.1 6677.0 6722.5 6723.7 6727.4 6730.3 6176.9 6226.5 6232.5 6238.3 6241.1 27250.2 28384.7 28929.3 29222.4 29286.7 2003.7 2066.5 2067.3 2070.3 2073.9 19024.8 19461.7 19534.8 19538.0 19554.8 2445.3 2446.9 2499.8 2508.3 2509.3 113889.9 120630.0 120704.0 123857.4 134559.3 15005.4 15112.7 15234.2 15263.2 15790.4 23812.6 23843.3 23898.3 23947.0 24016.3 10246.8 10408.4 10478.6 10499.7 10619.6 9716.5 9761.9 9775.0 9889.3 9903.2 9058.1 9139.7 9258.2 9336.0 9432.8 2696.7 2710.4 2716.9 2717.9 2800.7 927.4 960.4 965.3 969.7 986.5 19359.3 19422.3 19662.6 19783.0 19928.4 1018.9 1023.3 1038.9 1039.8 1044.2 10754.6 10879.2 11049.8 11112.5 11141.2 492050.0 495482.2 518178.0 519385.0 520579.0 108214.5 108488.7 110220.0 111075.4 115271.4 999.5 1008.9 1121.6 1170.3 1179.4 20406.7 20646.6 20862.9 20887.9 21123.2 55093.4 56731.7 56901.7 57035.7 58205.7 69784.0 69874.7 70252.0 71236.0 71282.0 14938.5 15126.4 15175.1 15234.5 15292.2 23714.2 23730.2 23902.4 24225.6 24361.8 18997.6 19099.0 19217.6 19258.8 19474.7 16811.3 17126.6 17416.7 17553.6 17695.5 18572.2 18987.1 19182.9 19380.7 19561.1 14866.1 14882.2 14904.9 14957.2 15218.2 18309.5 18413.8 18428.5 18536.5 18761.2 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#3] mootools.html Cycles:180 Average:9516.82 Median:2775.15 stddev:6791.05 (244.7%) stddev-sans-first:6781.97 20:30:06 INFO - PID 3819 | Values: 1291.0 1333.4 1344.8 1347.5 1350.5 15369.4 15796.8 15896.1 15913.3 15922.4 15643.5 15667.2 15798.3 15805.6 15834.4 2791.1 2841.7 2870.1 2874.3 2875.8 2768.9 2829.3 2837.3 2841.8 2853.0 2777.3 2798.9 2803.6 2803.8 2900.9 2875.7 2891.7 2892.4 2902.3 2906.0 2701.1 2719.1 2730.7 2752.8 2773.1 14741.5 15050.5 15248.8 15268.1 15529.9 8165.6 8409.3 8434.0 8437.1 8453.5 5562.2 5783.5 5906.9 5912.2 5932.5 1999.7 2021.9 2023.8 2045.8 2064.6 26761.5 26997.6 27009.3 27079.2 27091.7 6871.1 7010.2 7036.2 7255.0 7277.3 17519.2 17587.2 17644.7 17754.6 17762.6 8117.0 8267.1 8294.9 8326.1 8326.3 7459.1 7584.7 7642.7 7681.2 7697.5 5420.9 5522.2 5605.2 5629.2 5670.1 1668.4 1691.3 1692.9 1694.6 1704.6 830.1 846.9 868.3 877.3 880.7 7320.4 8231.7 8454.5 8511.5 8533.9 715.6 734.4 736.3 742.7 747.9 4640.0 4878.3 4921.7 4947.2 5052.8 21695.2 22021.3 22466.6 22558.2 22562.9 21330.1 21689.8 22147.8 22150.2 22401.1 10503.6 10545.3 10713.5 11033.7 11035.8 8366.7 8501.5 8565.2 8566.9 8658.9 18367.6 18890.1 18999.0 19143.6 19240.1 18285.3 19173.7 19432.7 19884.1 19987.1 11384.2 11634.5 11649.7 11673.4 11703.6 12626.9 13138.5 13461.5 13467.9 13480.5 11846.3 11919.2 11950.6 11959.7 12076.0 11357.1 11538.5 11559.6 11669.4 11731.6 9795.4 9828.7 9917.4 9952.2 9992.5 6814.2 6953.5 7015.1 7024.5 7099.0 7492.9 7564.8 7663.7 7701.3 7722.7 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#4] prototype.html Cycles:180 Average:5490.62 Median:6204.12 stddev:1517.40 (24.5%) stddev-sans-first:1474.77 20:30:06 INFO - PID 3819 | Values: 503.9 517.4 533.2 540.2 543.6 6203.5 6255.8 6277.4 6296.0 6402.1 6219.9 6261.8 6275.7 6285.7 6304.3 5192.4 5204.5 5221.9 5266.0 5267.6 5190.0 5207.5 5238.8 5262.0 5273.2 4744.6 4989.1 4991.1 4998.8 5028.5 5000.3 5019.1 5019.7 5046.1 5073.1 4494.4 4519.3 4521.8 4541.2 4541.7 5824.7 5997.9 6071.2 6084.9 6142.7 5582.3 5673.5 5726.3 5727.7 5745.0 6498.7 6541.9 6581.7 6586.6 6622.2 4650.7 4809.4 4835.5 4847.8 4869.3 6634.0 6709.4 6724.8 6731.9 6849.6 4922.4 4993.9 5051.6 5053.5 5069.7 5050.0 5087.4 5097.4 5107.3 5149.4 5641.5 5719.1 5724.7 5739.7 5773.5 6597.5 6619.4 6622.1 6626.5 6642.2 1749.2 1768.2 1773.8 1788.3 1794.5 1161.4 1233.2 1233.5 1236.8 1237.1 5643.0 5645.8 5652.1 5675.9 5719.7 6639.4 6647.5 6688.8 6720.4 6751.4 5627.7 5632.8 5647.8 5660.2 5689.0 3494.4 3516.5 3521.5 3536.9 3557.8 6205.5 6307.5 6319.8 6395.3 6462.9 6300.6 6588.0 6691.7 6756.9 6761.8 6342.5 6343.8 6360.8 6399.9 6410.4 6524.7 6608.6 6615.7 6621.4 6636.7 6466.9 6549.2 6562.9 6645.7 6734.3 6343.5 6353.9 6450.9 6493.5 6509.0 4896.6 4940.3 4998.4 5038.2 5071.4 6291.2 6546.0 6587.0 6635.3 6645.5 6204.8 6480.5 6513.6 6522.4 6600.4 6451.3 6504.5 6531.7 6536.7 6584.6 6343.0 6395.7 6412.9 6427.4 6493.2 6553.3 6560.0 6572.9 6599.3 6622.4 6296.6 6329.9 6340.5 6355.5 6387.4 20:30:06 INFO - PID 3819 | 20:30:06 INFO - PID 3819 | [#5] yui.html Cycles:180 Average:23702.99 Median:20405.49 stddev:34389.79 (168.5%) stddev-sans-first:34443.67 20:30:06 INFO - PID 3819 | Values: 908.4 912.5 926.7 931.9 941.2 19152.1 19941.9 20001.8 20002.3 20014.4 18201.5 18321.5 18431.4 18478.5 18549.2 945.5 961.9 962.1 966.9 967.3 956.1 962.2 965.8 969.2 969.5 938.5 973.5 1016.1 1020.2 1025.5 1014.6 1015.3 1018.4 1021.9 1023.2 736.7 742.8 742.8 746.5 746.9 20130.2 20680.8 20858.1 20889.3 20904.1 21623.1 22267.9 22354.3 22415.0 22514.8 17210.5 17401.1 17485.3 17494.2 17502.1 3637.4 3719.4 3733.2 3753.3 3786.2 137392.3 137875.3 141633.0 141748.0 142076.0 16649.9 16685.9 16735.0 16745.0 16884.4 31450.2 31669.4 31854.5 31937.4 31975.2 8138.4 8203.5 8220.4 8309.7 8402.4 4328.2 4342.1 4348.7 4352.8 4370.2 5452.3 5533.1 5576.2 5604.7 5622.2 1002.3 1009.6 1011.9 1014.2 1022.0 659.7 666.9 680.5 685.0 685.3 11064.9 11124.4 11240.8 11315.0 11397.3 644.1 658.2 658.6 661.5 668.1 5152.3 5206.7 5267.2 5280.7 5283.1 116550.0 116562.0 120279.4 120648.0 121115.0 98996.0 100033.0 102167.5 103484.0 104335.5 91000.5 91133.5 91897.5 92343.1 92473.0 9848.6 9970.0 10089.4 10164.5 10378.7 41853.6 43117.6 43129.1 44060.3 44134.6 53049.0 54133.5 55752.7 55834.7 55972.7 15183.2 15766.0 15810.8 15844.4 15881.0 17135.7 17312.8 17464.1 17508.1 17652.8 14022.4 14114.2 14184.0 14188.9 14455.3 14301.2 14494.1 14494.2 14564.6 14707.0 13624.5 13682.5 13857.1 13886.6 13979.9 11383.8 11580.8 11702.8 11980.6 12001.2 11372.8 11514.9 11520.2 11546.8 11649.1 20:30:06 INFO - PID 3819 | -------- Summary: end -------- 20:30:06 INFO - PID 3819 | 20:30:07 INFO - TEST-INFO | 3819: exit 0 20:30:07 INFO - TEST-OK | dromaeo_css | took 1117016ms 20:30:07 INFO - TEST-START | kraken 20:30:07 INFO - Initialising browser for kraken test... 20:30:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35298/getInfo.html -profile /tmp/tmpd2H6Rg/profile 20:30:07 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox http://localhost:35298/getInfo.html) 20:30:13 INFO - TEST-INFO | 4203: exit 0 20:30:13 INFO - Browser initialized. 20:30:13 INFO - Running cycle 1/1 for kraken test... 20:30:13 INFO - Using env: {'DISPLAY': ':0', 20:30:13 INFO - 'HOME': '/home/cltbld', 20:30:13 INFO - 'JSGC_DISABLE_POISONING': '1', 20:30:13 INFO - 'LANG': 'en_US.UTF-8', 20:30:13 INFO - 'LANGUAGE': 'en_US:en', 20:30:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:30:13 INFO - 'LOGNAME': 'cltbld', 20:30:13 INFO - 'MAIL': '/var/mail/cltbld', 20:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:30:13 INFO - 'MOZ_ACCELERATED': '1', 20:30:13 INFO - 'MOZ_CRASHREPORTER': '1', 20:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:30:13 INFO - 'MOZ_NO_REMOTE': '1', 20:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:30:13 INFO - 'MOZ_WEBRENDER': '1', 20:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:13 INFO - 'NO_EM_RESTART': '1', 20:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:13 INFO - 'PWD': '/builds/slave/test', 20:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:30:13 INFO - 'RUST_BACKTRACE': 'full', 20:30:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:30:13 INFO - 'SHELL': '/bin/bash', 20:30:13 INFO - 'SHLVL': '1', 20:30:13 INFO - 'TERM': 'linux', 20:30:13 INFO - 'TMOUT': '86400', 20:30:13 INFO - 'USER': 'cltbld', 20:30:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535', 20:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:13 INFO - '_': '/tools/buildbot/bin/python'} 20:30:13 INFO - TEST-INFO | started process 4451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2H6Rg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:14 INFO - PID 4451 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:30:14 INFO - PID 4451 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:30:14 INFO - PID 4451 | 20:30:14 INFO - PID 4451 | (/builds/slave/test/build/application/firefox/firefox:4511): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:30:14 INFO - PID 4451 | 20:30:25 INFO - PID 4451 | RSS: Main: 208068608 20:30:25 INFO - PID 4451 | 20:30:27 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35298/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:28 INFO - PID 4451 | RSS: Main: 205733888 20:30:28 INFO - PID 4451 | 20:30:31 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35298/tests/kraken/driver.html?testName=audio-dft) 20:30:32 INFO - PID 4451 | RSS: Main: 206032896 20:30:32 INFO - PID 4451 | 20:30:35 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35298/tests/kraken/driver.html?testName=audio-fft) 20:30:35 INFO - PID 4451 | RSS: Main: 203075584 20:30:35 INFO - PID 4451 | 20:30:37 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35298/tests/kraken/driver.html?testName=audio-oscillator) 20:30:38 INFO - PID 4451 | RSS: Main: 203313152 20:30:38 INFO - PID 4451 | 20:30:40 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:30:41 INFO - PID 4451 | RSS: Main: 204025856 20:30:41 INFO - PID 4451 | 20:30:44 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35298/tests/kraken/driver.html?testName=imaging-darkroom) 20:30:45 INFO - PID 4451 | RSS: Main: 206127104 20:30:45 INFO - PID 4451 | 20:30:48 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35298/tests/kraken/driver.html?testName=imaging-desaturate) 20:30:49 INFO - PID 4451 | RSS: Main: 205271040 20:30:49 INFO - PID 4451 | 20:30:52 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35298/tests/kraken/driver.html?testName=json-parse-financial) 20:30:53 INFO - PID 4451 | RSS: Main: 206487552 20:30:53 INFO - PID 4451 | 20:30:54 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:30:55 INFO - PID 4451 | RSS: Main: 206905344 20:30:55 INFO - PID 4451 | 20:30:57 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:57 INFO - PID 4451 | RSS: Main: 203685888 20:30:57 INFO - PID 4451 | 20:30:59 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:00 INFO - PID 4451 | RSS: Main: 203583488 20:31:00 INFO - PID 4451 | 20:31:03 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:03 INFO - PID 4451 | RSS: Main: 203538432 20:31:03 INFO - PID 4451 | 20:31:06 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:07 INFO - PID 4451 | RSS: Main: 203911168 20:31:07 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | Cycle 1(1): loaded http://localhost:35298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35298/tests/kraken/driver.html?testName=ai-astar) 20:31:09 INFO - PID 4451 | RSS: Main: 205262848 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | __start_tp_report 20:31:09 INFO - PID 4451 | _x_x_mozilla_page_load 20:31:09 INFO - PID 4451 | _x_x_mozilla_page_load_details 20:31:09 INFO - PID 4451 | |i|pagename|runs| 20:31:09 INFO - PID 4451 | |0;ai-astar;109;109;114;109;106;107;108;116;107;108 20:31:09 INFO - PID 4451 | |1;audio-beat-detection;116;121;119;116;121;118;115;141;126;128 20:31:09 INFO - PID 4451 | |2;audio-dft;167;174;166;163;175;170;177;163;167;163 20:31:09 INFO - PID 4451 | |3;audio-fft;73;78;75;74;80;77;77;78;74;78 20:31:09 INFO - PID 4451 | |4;audio-oscillator;87;83;82;80;81;80;86;78;85;87 20:31:09 INFO - PID 4451 | |5;imaging-gaussian-blur;115;114;116;114;114;116;114;127;119;114 20:31:09 INFO - PID 4451 | |6;imaging-darkroom;152;148;150;150;151;150;150;154;152;148 20:31:09 INFO - PID 4451 | |7;imaging-desaturate;104;99;95;94;94;96;104;101;95;93 20:31:09 INFO - PID 4451 | |8;json-parse-financial;52;54;52;54;61;60;56;55;53;51 20:31:09 INFO - PID 4451 | |9;json-stringify-tinderbox;44;39;38;39;49;38;47;48;45;40 20:31:09 INFO - PID 4451 | |10;stanford-crypto-aes;82;77;79;75;72;78;78;75;75;77 20:31:09 INFO - PID 4451 | |11;stanford-crypto-ccm;116;122;116;123;110;108;113;123;112;117 20:31:09 INFO - PID 4451 | |12;stanford-crypto-pbkdf2;175;176;173;175;169;168;171;170;172;168 20:31:09 INFO - PID 4451 | |13;stanford-crypto-sha256-iterative;66;68;67;71;66;65;66;67;69;73 20:31:09 INFO - PID 4451 | __end_tp_report 20:31:09 INFO - PID 4451 | __start_cc_report 20:31:09 INFO - PID 4451 | _x_x_mozilla_cycle_collect,794 20:31:09 INFO - PID 4451 | __end_cc_report 20:31:09 INFO - PID 4451 | __startTimestamp1505964669483__endTimestamp 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | ------- Summary: start ------- 20:31:09 INFO - PID 4451 | Number of tests: 14 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:3.20 (2.9%) stddev-sans-first:3.39 20:31:09 INFO - PID 4451 | Values: 109.0 109.0 114.0 109.0 106.0 107.0 108.0 116.0 107.0 108.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:121.00 stddev:7.89 (6.5%) stddev-sans-first:8.06 20:31:09 INFO - PID 4451 | Values: 116.0 121.0 119.0 116.0 121.0 118.0 115.0 141.0 126.0 128.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#2] audio-dft Cycles:10 Average:168.50 Median:168.50 stddev:5.25 (3.1%) stddev-sans-first:5.55 20:31:09 INFO - PID 4451 | Values: 167.0 174.0 166.0 163.0 175.0 170.0 177.0 163.0 167.0 163.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#3] audio-fft Cycles:10 Average:76.40 Median:77.50 stddev:2.27 (2.9%) stddev-sans-first:2.05 20:31:09 INFO - PID 4451 | Values: 73.0 78.0 75.0 74.0 80.0 77.0 77.0 78.0 74.0 78.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:84.00 stddev:3.21 (3.8%) stddev-sans-first:3.05 20:31:09 INFO - PID 4451 | Values: 87.0 83.0 82.0 80.0 81.0 80.0 86.0 78.0 85.0 87.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:115.50 stddev:4.08 (3.5%) stddev-sans-first:4.30 20:31:09 INFO - PID 4451 | Values: 115.0 114.0 116.0 114.0 114.0 116.0 114.0 127.0 119.0 114.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.84 (1.2%) stddev-sans-first:1.87 20:31:09 INFO - PID 4451 | Values: 152.0 148.0 150.0 150.0 151.0 150.0 150.0 154.0 152.0 148.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:94.50 stddev:4.20 (4.4%) stddev-sans-first:3.73 20:31:09 INFO - PID 4451 | Values: 104.0 99.0 95.0 94.0 94.0 96.0 104.0 101.0 95.0 93.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.36 (6.2%) stddev-sans-first:3.41 20:31:09 INFO - PID 4451 | Values: 52.0 54.0 52.0 54.0 61.0 60.0 56.0 55.0 53.0 51.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#9] json-stringify-tinderbox Cycles:10 Average:42.70 Median:44.50 stddev:4.37 (9.8%) stddev-sans-first:4.61 20:31:09 INFO - PID 4451 | Values: 44.0 39.0 38.0 39.0 49.0 38.0 47.0 48.0 45.0 40.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.50 stddev:2.74 (3.5%) stddev-sans-first:2.17 20:31:09 INFO - PID 4451 | Values: 82.0 77.0 79.0 75.0 72.0 78.0 78.0 75.0 75.0 77.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:116.50 stddev:5.37 (4.6%) stddev-sans-first:5.70 20:31:09 INFO - PID 4451 | Values: 116.0 122.0 116.0 123.0 110.0 108.0 113.0 123.0 112.0 117.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:2.98 (1.7%) stddev-sans-first:2.92 20:31:09 INFO - PID 4451 | Values: 175.0 176.0 173.0 175.0 169.0 168.0 171.0 170.0 172.0 168.0 20:31:09 INFO - PID 4451 | 20:31:09 INFO - PID 4451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.53 (3.7%) stddev-sans-first:2.60 20:31:09 INFO - PID 4451 | Values: 66.0 68.0 67.0 71.0 66.0 65.0 66.0 67.0 69.0 73.0 20:31:09 INFO - PID 4451 | -------- Summary: end -------- 20:31:09 INFO - PID 4451 | 20:31:10 INFO - PID 4451 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:31:10 INFO - TEST-INFO | 4451: exit 0 20:31:10 INFO - TEST-OK | kraken | took 63214ms 20:31:10 INFO - SUITE-END | took 1180s 20:31:10 INFO - Completed test suite (00:19:40) 20:31:10 INFO - javascript benchmark 20:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8499.448481144851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.830004349761, 3143.827089510077, 3156.873725050998, 3165.0504848545447, 3165.810051396916, 6354.364563543649, 6364.713587888545, 6376.33048529904, 6405.967970160143, 6408.359164083589, 6229.096780966757, 6286.968565157168, 6306.747730090802, 6323.462505687011, 6348.746050157988, 5867.413258674141, 5871.559633027518, 5874.206982057421, 5905.645661260338, 5947.970260148693, 5814.883702325951, 5894.734736936848, 5938.8218353449465, 5969.343372229051, 5982.8803423931495, 1137.0909503694097, 5730.914036289438, 5765.452282033221, 5945.672987985659, 5964.075568286922, 5816.88366232673, 5874.823755287348, 5880.764769409218, 5906.438888305647, 5917.644941303535, 5804.129380592903, 5804.52537814295, 5863.560232982501, 5867.266591676041, 5897.14491398749, 6291.8741625167695, 6323.20959880015, 6342.968285158545, 6397.904031439532, 6450.387213214737, 6720.596764194164, 6761.628110453923, 6771.593704377704, 6832.760853370158, 6887.862242755167, 6612.0412540181405, 6839.076724642159, 6849.554778939353, 6923.792286231421, 6931.41083007945, 6270.749170033193, 6303.401176888188, 6404.391582799627, 6424.71088801005, 6435.646039467827, 6974.930250697428, 7048.471364647672, 7054.365107140382, 7060.964695176492, 7076.540024898365, 6611.140551728245, 6651.16860392451, 6679.833004174934, 6752.358525940028, 6754.358335958076, 6603.306652801387, 6683.832904177337, 6703.530752847254, 6704.363085506869, 6719.857624203897, 6622.602643841385, 6661.100751398596, 6661.367170118831, 6689.163854518185, 6696.397324240745, 6637.46900247979, 6700.195976482756, 6715.227748808852, 6807.5575087619145, 6834.6582670866255, 5232.2413250078525, 5296.3379577552805, 5311.0, 5382.946170538323, 5384.138537833927, 4639.420072490939, 4641.187792136363, 4672.43930728308, 4675.555822196886, 4689.320048592935, 5759.6832174229985, 5779.8555036124435, 5784.958707432618, 5837.357890632027, 5848.883022339614, 6726.159230096238, 6778.186617605918, 6784.118064651662, 6830.248672646005, 6859.176898772179, 5739.139129130664, 5797.101449275369, 5798.10129429939, 5799.565032622486, 5800.332961709373, 5783.797567085216, 5785.652860828363, 5812.157237200582, 5820.767169313265, 5867.735951882176, 6403.743850245938, 6481.449076828428, 6483.448906842971, 6580.736770529221, 6581.111549940792, 6674.065630811788, 6694.665266736741, 6757.189137303555, 6792.252852186256, 6797.6941037654415, 6361.268454127649, 6485.0, 6523.151990241238, 6558.508111891722, 6620.801375958729, 6711.3288671132495, 6712.496562757715, 6775.390214880685, 6792.96603516999, 6798.626075565891, 6848.897266541106, 6854.9657251713425, 6894.965525172342, 6932.792016239521, 6934.895976560457, 6501.187351581052, 6519.185101862267, 6539.11721917554, 6582.868342633216, 6614.173228346457, 6449.903251451326, 6472.838179045561, 6488.935110649022, 6528.869422611426, 6535.542512024303, 6381.8085457436355, 6439.0, 6443.387878151568, 6443.96778016107, 6460.967695161494, 6625.734970601122, 6642.568233064835, 6686.13080299558, 6723.226828914738, 6749.223839258548, 6346.174997250328, 6413.583117097561, 6418.614883107029, 6467.256265529336, 6496.9025464617125], "value": 6139.621425028253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.3273146043277, 882.519027130214, 888.493558671557, 893.5576889439726, 894.2577660541747, 37460.81269593655, 40906.38640420392, 40922.386164207484, 41115.0, 41135.38296925545, 37465.62534374656, 37612.62387376125, 37638.247235055285, 37644.81177594115, 37665.62334376655, 7162.319579639939, 7392.963035184816, 7397.112346518398, 7399.223081576438, 7401.148867880182, 7273.163586187603, 7292.4530660200435, 7312.963435182816, 7328.413726901862, 7347.63261836906, 7278.126624805031, 7279.053723016001, 7306.196318404971, 7353.117625884901, 7365.300296471826, 7308.049953506037, 7904.328132108778, 8107.675692972274, 8119.0, 8125.268725814705, 7947.562884041376, 7950.045994480699, 7983.920160798376, 8010.879836802453, 8040.678372865078, 36653.0, 37003.0, 37083.0, 37213.255734885424, 37805.62194378076, 3560.0565850049757, 3608.079939615381, 3622.022054045393, 3635.0912271932016, 3637.1270894985014, 31964.360712785845, 32034.19914502156, 32043.679563204303, 32107.83946080278, 32224.355512889844, 5140.922886156711, 5151.356080489939, 5178.766955487012, 5212.530872221519, 5244.895102097937, 187130.0, 190727.0, 190769.04615476972, 190815.0, 191080.0, 41285.79357103195, 42653.0, 47840.5215947843, 47921.76039119852, 48240.758796205795, 50369.49630503648, 50621.240681389805, 50641.746791266545, 50707.23939140916, 50865.0, 16109.677806443806, 16252.268647910636, 16265.59336016609, 16269.91865040691, 16273.349066037463, 13286.3356832158, 13305.66735831612, 13318.733625327439, 13333.733325333438, 13335.133216340906, 14088.225147616979, 14171.362288697033, 14221.217833019284, 14237.85762142386, 14386.712265754626, 5840.707964601753, 5907.527397808165, 5933.525317974551, 5976.432238937294, 6025.698715064229, 985.3250523391499, 985.9852102218473, 1007.6422869881234, 1012.5392946209457, 1018.7809620931536, 21960.34118976433, 22200.333989980325, 22239.777602224094, 22380.776192238194, 22548.774512254666, 1098.242212873115, 1105.3257512917114, 1115.369816053927, 1119.5633702855894, 1123.1127409346525, 11882.88117118835, 12118.81821772674, 12195.878041219474, 12343.506259749689, 12395.380230988414, 228703.0, 230198.0, 230744.0, 231430.0, 231801.0, 52535.474645253824, 52671.73664131655, 52948.94102118013, 52983.0, 53042.46957530452, 1379.048456564967, 1460.7297649934796, 1462.641652795072, 1463.5682473670292, 1464.736347457468, 22270.888645556668, 22646.886765566065, 22678.433039174153, 22756.886215568815, 23016.539669206857, 36067.639323606425, 36551.45172822357, 36578.45132323071, 36621.816890915376, 36752.63247367492, 189604.0, 192747.0, 192781.0, 193264.0, 193457.0, 30897.227569310948, 31551.84224078865, 34000.65999339975, 34173.316533669684, 34255.486167708004, 43705.68882933517, 43840.561594384926, 43952.34071488994, 43993.340099899164, 44312.11375772531, 31730.365392692478, 32111.518327224643, 32308.83845580757, 32381.676183238807, 32603.836980815893, 31248.687513125486, 31445.371092578476, 31819.522707159875, 31861.522077169324, 31971.840140799148, 35661.465078023335, 35715.46426803652, 35740.64259357477, 35991.0, 36006.279874401844, 30993.380132397677, 31183.0, 31304.217394564406, 31483.0, 31686.0, 22634.773652263924, 22725.545489090455, 22827.657585136567, 22942.885285573466, 23221.3033608992], "value": 16989.420322464906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9781962338949, 561.5367321959385, 592.4608606168385, 607.7234858139547, 609.9603525770824, 21913.67129493057, 22624.66063009054, 22651.886740566315, 22690.65964010539, 22746.976386062626, 23577.29268121959, 23955.281341559737, 24417.389565260833, 25188.992440302365, 25324.493510129785, 6520.70656820443, 6634.038064480647, 6667.766628168015, 6699.397054265115, 6734.8989765153565, 6572.44134248587, 6585.37438943302, 6631.403173714365, 6639.634820084893, 6681.699323530428, 6353.428191462767, 6629.071929929813, 6637.435817955479, 6650.268470468244, 6693.129893113888, 6676.966615166917, 6722.495812814059, 6723.697433615474, 6727.360900714449, 6730.293319201512, 6176.907346389808, 6226.501879849601, 6232.532560058014, 6238.282597501255, 6241.063840423927, 27250.182494524997, 28384.716152838413, 28929.276768080967, 29222.415551688846, 29286.707132928612, 2003.7094621279832, 2066.524699319165, 2067.255787916364, 2070.265055905162, 2073.9377818665466, 19024.80975190244, 19461.708074378897, 19534.80465195344, 19538.0, 19554.804451955442, 2445.303088619735, 2446.9143579974616, 2499.7500249974855, 2508.28513873547, 2509.2973967289004, 113889.86110138876, 120630.0, 120704.0, 123857.38071309676, 134559.32720336335, 15005.445806728758, 15112.697746045018, 15234.238288085773, 15263.160526170945, 15790.447334343473, 23812.64281035786, 23843.284701458982, 23898.283051508482, 23947.0, 24016.27951161468, 10246.795064098676, 10408.427536485415, 10478.580856765797, 10499.737506562396, 10619.628313009007, 9716.514174291256, 9761.853572196424, 9774.951125244328, 9889.258305627107, 9903.207743380512, 9058.139476749699, 9139.680111196076, 9258.166764991183, 9335.953320233355, 9432.764180895532, 2696.7303269673266, 2710.430809529981, 2716.9079808547704, 2717.945641087167, 2800.747932686068, 927.4249965021595, 960.3805545423303, 965.3483898368573, 969.6896992962185, 986.5067466266867, 19359.3224237151, 19422.320218792276, 19662.606747864964, 19783.0, 19928.402147935583, 1018.872640919885, 1023.3143793658118, 1038.8597539332245, 1039.8024375368657, 1044.1698849414734, 10754.56981720738, 10879.184061195441, 11049.779004420026, 11112.499937502671, 11141.240801460892, 492050.0, 495482.21371528413, 518178.0, 519385.0, 520579.0, 108214.45892770485, 108488.74533764, 110220.0, 111075.44462277637, 115271.42364288124, 999.4552968632113, 1008.8587597736323, 1121.556984990924, 1170.2861254634665, 1179.4044007776017, 20406.693899591814, 20646.58706825825, 20862.895685521475, 20887.8955605221, 21123.155073796876, 55093.44906551044, 56731.71634141803, 56901.715491423936, 57035.71482142563, 58205.70897145487, 69784.0, 69874.65062674654, 70252.0, 71236.0, 71282.0, 14938.477153300017, 15126.39494420211, 15175.089494630358, 15234.542963711106, 15292.158931258888, 23714.170004049774, 23730.169444070067, 23902.402439938443, 24225.63661545043, 24361.75638243595, 18997.62004759925, 19099.0, 19217.61564768725, 19258.8074119257, 19474.707879381538, 16811.327546898476, 17126.571835704206, 17416.738748918524, 17553.561160970567, 17695.46913592594, 18572.164252608396, 18987.14557844928, 19182.904085479484, 19380.709289360388, 19561.119749611586, 14866.10803351759, 14882.181480018702, 14904.850951490347, 14957.17735524513, 15218.239088045331, 18309.54226144357, 18413.81586184121, 18428.539286517946, 18536.536586585444, 18761.155747991645], "value": 12085.085632493143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.95481658142, 1333.3799783100856, 1344.8367162404522, 1347.528365072225, 1350.5273154395968, 15369.385224591017, 15796.842031579696, 15896.12571308579, 15913.283902224399, 15922.442714504994, 15643.452479163232, 15667.216639168053, 15798.289076991534, 15805.60485987851, 15834.366625334973, 2791.0649932272613, 2841.6732075811287, 2870.124611993341, 2874.338902052529, 2875.8274503529856, 2768.8754006069676, 2829.264391258267, 2837.290677330667, 2841.77265818734, 2853.0, 2777.2501424615343, 2798.916032519028, 2803.579463080534, 2803.8177518461234, 2900.9129726108144, 2875.683674795771, 2891.667458242308, 2892.392597554516, 2902.3179552805072, 2905.970940290602, 2701.0546308791963, 2719.0891051497774, 2730.713275106125, 2752.7935404844516, 2773.057160565397, 14741.484048058373, 15050.473233436776, 15248.771268430983, 15268.083914965138, 15529.922350388175, 8165.591720413956, 8409.32725381968, 8433.95783021081, 8437.114103019156, 8453.492790432594, 5562.16567514872, 5783.479486846204, 5906.852328691817, 5912.201852749867, 5932.495737862287, 1999.720039194514, 2021.8980655542764, 2023.827974622159, 2045.815876571101, 2064.5870825834895, 26761.46477070467, 26997.570218680412, 27009.32476688079, 27079.187624371105, 27091.729082709116, 6871.14110736158, 7010.193827709777, 7036.155661320674, 7255.0, 7277.2722727726805, 17519.21163547618, 17587.208575613873, 17644.735328970077, 17754.644907101785, 17762.555936101442, 8116.959415202886, 8267.090620031791, 8294.917050829536, 8326.125756795449, 8326.25063744266, 7459.104907411145, 7584.696612135564, 7642.69429222836, 7681.155072941972, 7697.499662521918, 5420.864478387993, 5522.199281104217, 5605.159226116034, 5629.211910332557, 5670.149477578314, 1668.416054380957, 1691.2727527163438, 1692.8645708343304, 1694.6102396448887, 1704.6164612962232, 830.1283652165203, 846.8856704344958, 868.2880038368603, 877.3025444771422, 880.7313769300297, 7320.414366850639, 8231.670733170726, 8454.535000575028, 8511.489310641382, 8533.871991920127, 715.6314498033516, 734.3757805864972, 736.348331726426, 742.6769355330448, 747.9027726395534, 4639.9536004640195, 4878.317035615017, 4921.680090794159, 4947.183714687037, 5052.823151189691, 21695.240666576596, 22021.33935981923, 22466.550668986856, 22558.21046263406, 22562.887185564294, 21330.14679412837, 21689.78310216909, 22147.778522214892, 22150.22474213427, 22401.10395584191, 10503.579856805794, 10545.261831671864, 10713.464326783629, 11033.668989930315, 11035.779284414266, 8366.74899752984, 8501.489910605384, 8565.229129378386, 8566.91433085661, 8658.870116948125, 18367.632647347247, 18890.149943252312, 18999.0, 19143.61712765709, 19240.134193961585, 18285.26858925681, 19173.712394313818, 19432.70850937209, 19884.10521526506, 19987.100580473623, 11384.203105782846, 11634.476448559666, 11649.650510484698, 11673.357965311989, 11703.590374336858, 12626.873731262569, 13138.474461021453, 13461.528846490326, 13467.932660336635, 13480.5281815136, 11846.289222646325, 11919.225250359046, 11950.581729639422, 11959.701007474883, 12076.0, 11357.148213883827, 11538.480768365276, 11559.595414160463, 11669.416529173337, 11731.648050558497, 9795.412275263507, 9828.705138845846, 9917.404955702681, 9952.203823694232, 9992.500374981077, 6814.184056928136, 6953.478489113236, 7015.052967849275, 7024.473164512784, 7099.006139140628, 7492.887606685795, 7564.773056808304, 7663.655135519027, 7701.345385642283, 7722.7297044603165], "value": 6779.935016010218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.9143345631242, 517.4024002277368, 533.2454576773865, 540.2436588775713, 543.6004536665553, 6203.480147363896, 6255.781047663333, 6277.435030847223, 6295.968520157398, 6402.135711678922, 6219.906701399483, 6261.843453913654, 6275.748970041204, 6285.6857157142185, 6304.33804450533, 5192.416313024526, 5204.531592156714, 5221.947780522203, 5265.973670131644, 5267.601552703497, 5190.013897359489, 5207.4792520748, 5238.816641417551, 5262.0, 5273.209018647195, 4744.57298843104, 4989.126902791997, 4991.076650819592, 4998.750062496879, 5028.547430731233, 5000.349954505909, 5019.071471777733, 5019.749012549394, 5046.142155833517, 5073.137566613685, 4494.393256910308, 4519.299508576176, 4521.796519156645, 4541.227991241497, 4541.6593755468475, 5824.650520968713, 5997.8800423991715, 6071.150038994544, 6084.908726369108, 6142.662153581551, 5582.330120385539, 5673.489385955242, 5726.284214473191, 5727.742251598688, 5744.971275143597, 6498.675066246668, 6541.869162616721, 6581.7367305307735, 6586.571872828251, 6622.165818952192, 4650.7442090685, 4809.446913604946, 4835.492273311322, 4847.842709994054, 4869.2939523768855, 6634.0, 6709.429698475636, 6724.78082232862, 6731.93268067318, 6849.589024658537, 4922.4339200992345, 4993.850184494471, 5051.595872330205, 5053.545180933734, 5069.746512674352, 5049.974750126225, 5087.364079490064, 5097.439281679012, 5107.310513080761, 5149.433562308143, 5641.548676105902, 5719.113537401709, 5724.681503990891, 5739.713014349266, 5773.509251713567, 6597.47220222381, 6619.437347825488, 6622.145799176238, 6626.503012274099, 6642.202935647657, 1749.1691446562781, 1768.2308195934809, 1773.8137495563037, 1788.2936240185054, 1794.5065107095654, 1161.3902701081831, 1233.1984210263402, 1233.481937586216, 1236.7773800715956, 1237.1401875696486, 5642.996736158687, 5645.774169033275, 5652.123920792284, 5675.886482270332, 5719.742611582489, 6639.435647969976, 6647.501437392215, 6688.765893193715, 6720.428763555153, 6751.392374686204, 5627.71861406928, 5632.831015069554, 5647.802326918538, 5660.150977353348, 5688.971555142198, 3494.423420135649, 3516.542849429558, 3521.489384039351, 3536.876209332661, 3557.7509574329547, 6205.503559715212, 6307.5269354798575, 6319.810405687745, 6395.2645445773405, 6462.903056454063, 6300.59046161998, 6588.0, 6691.7323307068145, 6756.898646520306, 6761.763338283136, 6342.492600592034, 6343.777967771106, 6360.759651867934, 6399.936000639934, 6410.423061924449, 6524.67376631176, 6608.6034837907955, 6615.717577435777, 6621.370969757865, 6636.739019586264, 6466.865934241595, 6549.214094308523, 6562.934370656423, 6645.704087702851, 6734.292899245705, 6343.492520598434, 6353.9046914295395, 6450.903236451363, 6493.512986525935, 6509.02364645307, 4896.579991802338, 4940.333055037668, 4998.4251811042195, 5038.193888977746, 5071.39143302806, 6291.213598300213, 6545.985372267306, 6586.951961401254, 6635.270120286668, 6645.534812563074, 6204.751809927552, 6480.481561474976, 6513.576617519846, 6522.412982831568, 6600.438962688033, 6451.3226111257645, 6504.528279253853, 6531.706073226621, 6536.738530458729, 6584.572002819801, 6343.016832390987, 6395.744170233139, 6412.9358706414205, 6427.421532062137, 6493.155889734304, 6553.311902250195, 6560.048792925095, 6572.934270657232, 6599.340065993362, 6622.437092847162, 6296.590721603081, 6329.90505142414, 6340.463814474063, 6355.523335749745, 6387.425131738166], "value": 5047.3491123608865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.3596064774334, 912.4844462878473, 926.6525053105086, 931.9114684105008, 941.1764705882351, 19152.13815378308, 19941.900290498565, 20001.799982000175, 20002.29991950282, 20014.39956801295, 18201.45395638133, 18321.534277257822, 18431.447056588324, 18478.538036549093, 18549.165287562057, 945.4658118163233, 961.8749562556858, 962.1100482054072, 966.9274804389664, 967.2842096848317, 956.1060408518058, 962.1725316228038, 965.8213230552335, 969.1810420194925, 969.4764826993451, 938.4650749072997, 973.5229737428645, 1016.11090295991, 1020.1583693452894, 1025.5077562769875, 1014.6296601740312, 1015.2639336481066, 1018.4347687033693, 1021.8722659667542, 1023.2325755683238, 736.7384578474617, 742.8365759532949, 742.8440027594212, 746.518495570354, 746.8917007033949, 20130.194792208295, 20680.79319206804, 20858.061387237613, 20889.268875589434, 20904.059317330757, 21623.135074596998, 22267.888660556757, 22354.32937011892, 22415.0, 22514.77485225143, 17210.483685489457, 17401.129943502776, 17485.30058797659, 17494.212760425686, 17502.124893755263, 3637.381645120336, 3719.3677074897064, 3733.2346868891814, 3753.3056384568667, 3786.1670432504807, 137392.31303843416, 137875.31062344724, 141633.0, 141748.0, 142076.0, 16649.91675041617, 16685.91657041707, 16735.0, 16745.0, 16884.409045683587, 31450.21374465657, 31669.366612667618, 31854.522182167286, 31937.361252775278, 31975.20061998422, 8138.430309878252, 8203.548804815673, 8220.424570280024, 8309.709160179365, 8402.369822263354, 4328.177646247203, 4342.131573685276, 4348.717333373321, 4352.825886964486, 4370.191514569815, 5452.318460192476, 5533.08704063833, 5576.247206627135, 5604.747786349624, 5622.156676498558, 1002.3334482569155, 1009.5810238750983, 1011.9190464762802, 1014.2038499777639, 1021.9693409197736, 659.7130248341987, 666.8966310221923, 680.496432639843, 684.9965750171317, 685.3146853146853, 11064.889351106547, 11124.38815865119, 11240.775184496264, 11315.03822175108, 11397.316161030365, 644.0532417346493, 658.236445722959, 658.5949640970769, 661.5270081891471, 668.1214203322616, 5152.278680984665, 5206.739663016834, 5267.236250743697, 5280.709560974184, 5283.101872681654, 116550.0, 116562.0, 120279.36368272068, 120648.0, 121115.0, 98996.0, 100033.0, 102167.48916255371, 103484.0, 104335.4783226079, 91000.54499727458, 91133.54433227792, 91897.54051229701, 92343.07656923479, 92473.0, 9848.556814943202, 9970.0, 10089.445080520642, 10164.542595583069, 10378.688639340831, 41853.58146418619, 43117.568824311355, 43129.13741725211, 44060.33909491424, 44134.55865441304, 53049.0, 54133.45866541284, 55752.72123639356, 55834.720826395605, 55972.72013639906, 15183.164925928739, 15766.0, 15810.7628385572, 15844.366225350857, 15881.0, 17135.742963855802, 17312.826871731122, 17464.12679366052, 17508.124593770004, 17652.823471765118, 14022.368993395527, 14114.223717695626, 14184.0, 14188.858111418755, 14455.349509272319, 14301.213433261271, 14494.05788623736, 14494.202818845064, 14564.635884102981, 14707.044042137228, 13624.52314169039, 13682.452701891812, 13857.099288546213, 13886.583402497941, 13979.881609471422, 11383.829242561202, 11580.826287605862, 11702.824457632973, 11980.64058078259, 12001.219920705125, 11372.829407559058, 11514.94242528782, 11520.193586448868, 11546.769064618493, 11649.068074553847], "value": 8738.970387114954, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 114.0, 109.0, 106.0, 107.0, 108.0, 116.0, 107.0, 108.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 119.0, 116.0, 121.0, 118.0, 115.0, 141.0, 126.0, 128.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 166.0, 163.0, 175.0, 170.0, 177.0, 163.0, 167.0, 163.0], "value": 168.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 75.0, 74.0, 80.0, 77.0, 77.0, 78.0, 74.0, 78.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 82.0, 80.0, 81.0, 80.0, 86.0, 78.0, 85.0, 87.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 114.0, 114.0, 116.0, 114.0, 127.0, 119.0, 114.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 150.0, 150.0, 151.0, 150.0, 150.0, 154.0, 152.0, 148.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 99.0, 95.0, 94.0, 94.0, 96.0, 104.0, 101.0, 95.0, 93.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 54.0, 61.0, 60.0, 56.0, 55.0, 53.0, 51.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 39.0, 38.0, 39.0, 49.0, 38.0, 47.0, 48.0, 45.0, 40.0], "value": 42.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 79.0, 75.0, 72.0, 78.0, 78.0, 75.0, 75.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 116.0, 123.0, 110.0, 108.0, 113.0, 123.0, 112.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 173.0, 175.0, 169.0, 168.0, 171.0, 170.0, 172.0, 168.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 71.0, 66.0, 65.0, 66.0, 67.0, 69.0, 73.0], "value": 67.8, "unit": "score"}]}]} 20:31:10 INFO - Return code: 0 20:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:10 INFO - # TBPL SUCCESS # 20:31:10 INFO - Running post-action listener: _package_coverage_data 20:31:10 INFO - Running post-action listener: _resource_record_post_action 20:31:10 INFO - [mozharness: 2017-09-21 03:31:10.762885Z] Finished run-tests step (success) 20:31:10 INFO - Running post-run listener: _resource_record_post_run 20:31:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 19513344; Write bytes: 455020544; Read time: 13420; Write time: 734904 20:31:10 INFO - TinderboxPrint: CPU usage
13.3% 20:31:10 INFO - TinderboxPrint: I/O read bytes / time
19,513,344 / 13,420 20:31:10 INFO - TinderboxPrint: I/O write bytes / time
455,020,544 / 734,904 20:31:10 INFO - TinderboxPrint: CPU idle
8,282.8 (86.7%) 20:31:10 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 20:31:10 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 159379456; Read time: 0; Write time: 226748 20:31:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:31:10 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 17141760; Write bytes: 295641088; Read time: 12972; Write time: 508156 20:31:11 INFO - Running post-run listener: _upload_blobber_files 20:31:11 INFO - Blob upload gear active. 20:31:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:11 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 20:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:11 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:12 INFO - (blobuploader) - INFO - Done attempting. 20:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:13 INFO - (blobuploader) - INFO - Done attempting. 20:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:20 INFO - (blobuploader) - INFO - Done attempting. 20:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:22 INFO - (blobuploader) - INFO - Done attempting. 20:31:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:22 INFO - Return code: 0 20:31:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74160197d0241ee31fd50a7c95a6cfad8f88de1a92389f5d54e8365be583d55d9ca83c3bd6cc88010004132c04de61df6693a5a59a899c7b732afde37508c9c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbe2be1da1aefa3462946525bb5071d82ccbede9fc34eaf8b5c1f5502809257e0b1abf046a1edd431a5d7f106575b4be8c96e49c49254e35800c5afb06bc09f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37462aad791595c392e59ba3a155a18bb029d108bd00aa255b98210af72e8f4308eb003d4eeb696d1c8585446b61fbceb28be4eb3e38e21118bfc790c07ea4db", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/395fbc5aa438941eac27f2fa3323d6949ac7df96805adc0821c4af489dfca897c235e59bf55d7dfebe3ac4b4d8886b082a5f25f7ba7bb00eba2a4684703a8b49"} 20:31:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:22 INFO - Contents: 20:31:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74160197d0241ee31fd50a7c95a6cfad8f88de1a92389f5d54e8365be583d55d9ca83c3bd6cc88010004132c04de61df6693a5a59a899c7b732afde37508c9c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbe2be1da1aefa3462946525bb5071d82ccbede9fc34eaf8b5c1f5502809257e0b1abf046a1edd431a5d7f106575b4be8c96e49c49254e35800c5afb06bc09f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37462aad791595c392e59ba3a155a18bb029d108bd00aa255b98210af72e8f4308eb003d4eeb696d1c8585446b61fbceb28be4eb3e38e21118bfc790c07ea4db", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/395fbc5aa438941eac27f2fa3323d6949ac7df96805adc0821c4af489dfca897c235e59bf55d7dfebe3ac4b4d8886b082a5f25f7ba7bb00eba2a4684703a8b49"} 20:31:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:22 INFO - Copying logs to upload dir... 20:31:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.808217 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-20 20:31:22.222155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 20:31:22.229367) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 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/Firefox/sha512/74160197d0241ee31fd50a7c95a6cfad8f88de1a92389f5d54e8365be583d55d9ca83c3bd6cc88010004132c04de61df6693a5a59a899c7b732afde37508c9c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbe2be1da1aefa3462946525bb5071d82ccbede9fc34eaf8b5c1f5502809257e0b1abf046a1edd431a5d7f106575b4be8c96e49c49254e35800c5afb06bc09f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37462aad791595c392e59ba3a155a18bb029d108bd00aa255b98210af72e8f4308eb003d4eeb696d1c8585446b61fbceb28be4eb3e38e21118bfc790c07ea4db", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/395fbc5aa438941eac27f2fa3323d6949ac7df96805adc0821c4af489dfca897c235e59bf55d7dfebe3ac4b4d8886b082a5f25f7ba7bb00eba2a4684703a8b49"} build_url:https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/e3qcQ5inSsinAoBQTeRgAQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74160197d0241ee31fd50a7c95a6cfad8f88de1a92389f5d54e8365be583d55d9ca83c3bd6cc88010004132c04de61df6693a5a59a899c7b732afde37508c9c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbe2be1da1aefa3462946525bb5071d82ccbede9fc34eaf8b5c1f5502809257e0b1abf046a1edd431a5d7f106575b4be8c96e49c49254e35800c5afb06bc09f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37462aad791595c392e59ba3a155a18bb029d108bd00aa255b98210af72e8f4308eb003d4eeb696d1c8585446b61fbceb28be4eb3e38e21118bfc790c07ea4db", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/395fbc5aa438941eac27f2fa3323d6949ac7df96805adc0821c4af489dfca897c235e59bf55d7dfebe3ac4b4d8886b082a5f25f7ba7bb00eba2a4684703a8b49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 20:31:22.260901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:31:22.261298) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505958950.835257-1433684535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:31:22.344300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 20:31:22.344607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 20:31:22.348006) ========= ========= Total master_lag: 0.39 =========