builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1505375670.48 results: success (0) revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.479769) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.480351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.480661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.611920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.612229) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 00:54:30-- 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% 110M=0s 2017-09-14 00:54:30 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.766037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.766376) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015053 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.868201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:30.868577) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:54:30,800 truncating revision to first 12 chars 2017-09-14 00:54:30,800 Setting DEBUG logging. 2017-09-14 00:54:30,800 attempt 1/10 2017-09-14 00:54:30,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4702042aa919?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 00:54:31,716 unpacking tar archive at: mozilla-central-4702042aa919/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:32.086620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.087093) ========= script_repo_revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.087555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.088207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.101461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-14 00:54:32.101856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:54:32 INFO - MultiFileLogger online at 20170914 00:54:32 in /builds/slave/test 00:54:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:54:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:54:32 INFO - {'append_to_log': False, 00:54:32 INFO - 'base_work_dir': '/builds/slave/test', 00:54:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:54:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:54:32 INFO - 'branch': 'Firefox-Non-PGO', 00:54:32 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:32 INFO - 'code_coverage': False, 00:54:32 INFO - 'config_files': ('talos/linux_config.py',), 00:54:32 INFO - 'default_actions': ('clobber', 00:54:32 INFO - 'read-buildbot-config', 00:54:32 INFO - 'download-and-extract', 00:54:32 INFO - 'populate-webroot', 00:54:32 INFO - 'create-virtualenv', 00:54:32 INFO - 'install', 00:54:32 INFO - 'setup-mitmproxy', 00:54:32 INFO - 'run-tests'), 00:54:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:32 INFO - 'disable_ccov_upload': False, 00:54:32 INFO - 'disable_stylo': False, 00:54:32 INFO - 'download_minidump_stackwalk': True, 00:54:32 INFO - 'download_symbols': 'ondemand', 00:54:32 INFO - 'enable_stylo': False, 00:54:32 INFO - 'enable_webrender': False, 00:54:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:54:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:32 INFO - 'gecko_profile': False, 00:54:32 INFO - 'gecko_profile_interval': 0, 00:54:32 INFO - 'installer_path': 'installer.exe', 00:54:32 INFO - 'log_level': 'info', 00:54:32 INFO - 'log_name': 'talos', 00:54:32 INFO - 'log_to_console': True, 00:54:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:54:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:54:32 INFO - 'opt_config_files': (), 00:54:32 INFO - 'pip_index': False, 00:54:32 INFO - 'suite': 'dromaeojs-e10s', 00:54:32 INFO - 'system_bits': '32', 00:54:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:32 INFO - 'title': 'talos-linux64-ix-059', 00:54:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:32 INFO - 'use_talos_json': True, 00:54:32 INFO - 'verify': 'False', 00:54:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:54:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:32 INFO - 'work_dir': 'build'} 00:54:32 INFO - [mozharness: 2017-09-14 07:54:32.168359Z] Running clobber step. 00:54:32 INFO - Running pre-action listener: _resource_record_pre_action 00:54:32 INFO - Running main action method: clobber 00:54:32 INFO - rmtree: /builds/slave/test/build 00:54:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:54:33 INFO - Running post-action listener: _resource_record_post_action 00:54:33 INFO - [mozharness: 2017-09-14 07:54:33.157307Z] Finished clobber step (success) 00:54:33 INFO - [mozharness: 2017-09-14 07:54:33.157405Z] Running read-buildbot-config step. 00:54:33 INFO - Running pre-action listener: _resource_record_pre_action 00:54:33 INFO - Running main action method: read_buildbot_config 00:54:33 INFO - Using buildbot properties: 00:54:33 INFO - { 00:54:33 INFO - "project": "", 00:54:33 INFO - "product": "firefox", 00:54:33 INFO - "who": "kwierso@gmail.com", 00:54:33 INFO - "installer_path": "public/build/target.tar.bz2", 00:54:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:54:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:54:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 00:54:33 INFO - "stage_platform": "linux64", 00:54:33 INFO - "basedir": "/builds/slave/test", 00:54:33 INFO - "buildnumber": 1147, 00:54:33 INFO - "platform": "ubuntu64_hw", 00:54:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:54:33 INFO - "slavebuilddir": "test", 00:54:33 INFO - "taskId": "KtArVoAIShmAOA6Av5s4CA", 00:54:33 INFO - "branch": "mozilla-central", 00:54:33 INFO - "script_repo_revision": "production", 00:54:33 INFO - "revision": "4702042aa919d5ae49dfe3ac5ee86507839b3c83", 00:54:33 INFO - "slavename": "talos-linux64-ix-059", 00:54:33 INFO - "repo_path": "mozilla-central" 00:54:33 INFO - } 00:54:33 INFO - Finding installer, test and symbols from parent task. 00:54:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KtArVoAIShmAOA6Av5s4CA'}, attempt #1 00:54:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KtArVoAIShmAOA6Av5s4CA'}, attempt #1 00:54:34 INFO - Task dependencies: L_3yr4h9Spyt82QzKDJcnw 00:54:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw'}, attempt #1 00:54:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip 00:54:34 INFO - Running post-action listener: _resource_record_post_action 00:54:34 INFO - [mozharness: 2017-09-14 07:54:34.653333Z] Finished read-buildbot-config step (success) 00:54:34 INFO - [mozharness: 2017-09-14 07:54:34.653552Z] Running download-and-extract step. 00:54:34 INFO - Running pre-action listener: _resource_record_pre_action 00:54:34 INFO - Running main action method: download_and_extract 00:54:34 INFO - mkdir: /builds/slave/test/build/tests 00:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:34 INFO - trying https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:34 INFO - Downloading https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:54:35 INFO - Downloaded 989 bytes. 00:54:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:54:35 INFO - Using the following test package requirements: 00:54:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:54:35 INFO - u'common': [u'target.common.tests.zip'], 00:54:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:54:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:54:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:54:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:54:35 INFO - u'mozbase': [u'target.common.tests.zip'], 00:54:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:54:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:54:35 INFO - u'web-platform': [u'target.common.tests.zip', 00:54:35 INFO - u'target.web-platform.tests.tar.gz'], 00:54:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:54:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:54:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip 00:54:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:54:35 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip into memory 00:54:37 INFO - Content-Length response header: 54588745 00:54:37 INFO - Bytes received: 54588745 00:54:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip 00:54:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:54:48 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip into memory 00:54:49 INFO - Content-Length response header: 14500356 00:54:49 INFO - Bytes received: 14500356 00:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:50 INFO - trying https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:50 INFO - Downloading https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:54:51 INFO - Downloaded 61305213 bytes. 00:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:51 INFO - mkdir: /builds/slave/test/properties 00:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 00:54:51 INFO - Contents: 00:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:51 INFO - Running post-action listener: _resource_record_post_action 00:54:51 INFO - Running post-action listener: find_tests_for_verification 00:54:51 INFO - Running post-action listener: set_extra_try_arguments 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.298017Z] Finished download-and-extract step (success) 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.298114Z] Running populate-webroot step. 00:54:51 INFO - Running pre-action listener: _resource_record_pre_action 00:54:51 INFO - Running main action method: populate_webroot 00:54:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:54:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tresize', 00:54:51 INFO - 'tcanvasmark']}, 00:54:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:54:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['dromaeo_css', 00:54:51 INFO - 'kraken']}, 00:54:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['damp', 'tps']}, 00:54:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['damp', 'tps']}, 00:54:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:54:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['dromaeo_dom']}, 00:54:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:54:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['basic_compositor_video', 00:54:51 INFO - 'glvideo']}, 00:54:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:54:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['ts_paint_webext', 00:54:51 INFO - 'tp5o_webext']}, 00:54:51 INFO - 'other-e10s': {'tests': ['a11yr', 00:54:51 INFO - 'ts_paint', 00:54:51 INFO - 'tpaint', 00:54:51 INFO - 'sessionrestore', 00:54:51 INFO - 'sessionrestore_many_windows', 00:54:51 INFO - 'sessionrestore_no_auto_restore', 00:54:51 INFO - 'tabpaint']}, 00:54:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['a11yr', 00:54:51 INFO - 'ts_paint', 00:54:51 INFO - 'tpaint', 00:54:51 INFO - 'sessionrestore', 00:54:51 INFO - 'sessionrestore_many_windows', 00:54:51 INFO - 'sessionrestore_no_auto_restore', 00:54:51 INFO - 'tabpaint']}, 00:54:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:54:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:54:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['bloom_basic_singleton']}, 00:54:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['bloom_basic']}, 00:54:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:54:51 INFO - 'tsvgr_opacity', 00:54:51 INFO - 'tart', 00:54:51 INFO - 'tscrollx', 00:54:51 INFO - 'tsvg_static']}, 00:54:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tsvgx', 00:54:51 INFO - 'tsvgr_opacity', 00:54:51 INFO - 'tart', 00:54:51 INFO - 'tscrollx', 00:54:51 INFO - 'tsvg_static']}, 00:54:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:54:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tp5o']}, 00:54:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo', 00:54:51 INFO - '--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--stylo-threads=1', 00:54:51 INFO - '--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--xperf_path', 00:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:51 INFO - 'tests': ['tp5n']}, 00:54:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo', 00:54:51 INFO - '--xperf_path', 00:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:51 INFO - 'tests': ['tp5n']}}} 00:54:51 INFO - Running post-action listener: _resource_record_post_action 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.313312Z] Finished populate-webroot step (success) 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.313401Z] Running create-virtualenv step. 00:54:51 INFO - Running pre-action listener: _resource_record_pre_action 00:54:51 INFO - Running main action method: create_virtualenv 00:54:51 INFO - Creating virtualenv /builds/slave/test/build/venv 00:54:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:54:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:54:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:54:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:54:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:54:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:54:53 INFO - Installing pip...............done. 00:54:53 INFO - Return code: 0 00:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:54:53 INFO - Reading from file tmpfile_stdout 00:54:53 INFO - Output received: 00:54:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 00:54:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:54: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')]} 00:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54: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')]} 00:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:54: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', 'pip>=1.5'] in /builds/slave/test/build 00:54: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 pip>=1.5 00:54:53 INFO - Using env: {'DISPLAY': ':0', 00:54:53 INFO - 'HOME': '/home/cltbld', 00:54:53 INFO - 'LANG': 'en_US.UTF-8', 00:54:53 INFO - 'LANGUAGE': 'en_US:en', 00:54:53 INFO - 'LOGNAME': 'cltbld', 00:54:53 INFO - 'MAIL': '/var/mail/cltbld', 00:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:53 INFO - 'MOZ_NO_REMOTE': '1', 00:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:53 INFO - 'NO_EM_RESTART': '1', 00:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:53 INFO - 'PWD': '/builds/slave/test', 00:54:53 INFO - 'SHELL': '/bin/bash', 00:54:53 INFO - 'SHLVL': '1', 00:54:53 INFO - 'TERM': 'linux', 00:54:53 INFO - 'TMOUT': '86400', 00:54:53 INFO - 'USER': 'cltbld', 00:54:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:53 INFO - '_': '/tools/buildbot/bin/python'} 00:54:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:54:54 INFO - Downloading/unpacking pip>=1.5 00:54:54 INFO - Running setup.py egg_info for package pip 00:54:54 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:54 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:54 INFO - Installing collected packages: pip 00:54:54 INFO - Found existing installation: pip 1.1 00:54:54 INFO - Uninstalling pip: 00:54:54 INFO - Successfully uninstalled pip 00:54:54 INFO - Running setup.py install for pip 00:54:54 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:54 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:54:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:54:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:54:54 INFO - Successfully installed pip 00:54:54 INFO - Cleaning up... 00:54:54 INFO - Return code: 0 00:54:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:54:54 INFO - Using env: {'DISPLAY': ':0', 00:54:54 INFO - 'HOME': '/home/cltbld', 00:54:54 INFO - 'LANG': 'en_US.UTF-8', 00:54:54 INFO - 'LANGUAGE': 'en_US:en', 00:54:54 INFO - 'LOGNAME': 'cltbld', 00:54:54 INFO - 'MAIL': '/var/mail/cltbld', 00:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:54 INFO - 'MOZ_NO_REMOTE': '1', 00:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:54 INFO - 'NO_EM_RESTART': '1', 00:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:54 INFO - 'PWD': '/builds/slave/test', 00:54:54 INFO - 'SHELL': '/bin/bash', 00:54:54 INFO - 'SHLVL': '1', 00:54:54 INFO - 'TERM': 'linux', 00:54:54 INFO - 'TMOUT': '86400', 00:54:54 INFO - 'USER': 'cltbld', 00:54:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:54 INFO - '_': '/tools/buildbot/bin/python'} 00:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:55 INFO - Downloading/unpacking psutil>=3.1.1 00:54:55 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 00:54:55 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 00:54:55 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 00:54:55 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 00:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:54:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:56 INFO - Installing collected packages: psutil 00:54:56 INFO - Running setup.py install for psutil 00:54:56 INFO - building 'psutil._psutil_linux' extension 00:54:56 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 00:54: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 00:54:56 INFO - building 'psutil._psutil_posix' extension 00:54: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 00:54: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 00:54:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:56 INFO - Successfully installed psutil 00:54:56 INFO - Cleaning up... 00:54:56 INFO - Return code: 0 00:54:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:54: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')]} 00:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54: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')]} 00:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54: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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:54: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 00:54: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 00:54:56 INFO - Using env: {'DISPLAY': ':0', 00:54:56 INFO - 'HOME': '/home/cltbld', 00:54:56 INFO - 'LANG': 'en_US.UTF-8', 00:54:56 INFO - 'LANGUAGE': 'en_US:en', 00:54:56 INFO - 'LOGNAME': 'cltbld', 00:54:56 INFO - 'MAIL': '/var/mail/cltbld', 00:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:56 INFO - 'MOZ_NO_REMOTE': '1', 00:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:56 INFO - 'NO_EM_RESTART': '1', 00:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:56 INFO - 'PWD': '/builds/slave/test', 00:54:56 INFO - 'SHELL': '/bin/bash', 00:54:56 INFO - 'SHLVL': '1', 00:54:56 INFO - 'TERM': 'linux', 00:54:56 INFO - 'TMOUT': '86400', 00:54:56 INFO - 'USER': 'cltbld', 00:54:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:56 INFO - '_': '/tools/buildbot/bin/python'} 00:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:54:58 INFO - Installing collected packages: mozsystemmonitor 00:54:58 INFO - Running setup.py install for mozsystemmonitor 00:54:58 INFO - Successfully installed mozsystemmonitor 00:54:58 INFO - Cleaning up... 00:54:58 INFO - Return code: 0 00:54:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:54: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')]} 00:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54: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')]} 00:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54: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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:54: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 00:54: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 00:54:58 INFO - Using env: {'DISPLAY': ':0', 00:54:58 INFO - 'HOME': '/home/cltbld', 00:54:58 INFO - 'LANG': 'en_US.UTF-8', 00:54:58 INFO - 'LANGUAGE': 'en_US:en', 00:54:58 INFO - 'LOGNAME': 'cltbld', 00:54:58 INFO - 'MAIL': '/var/mail/cltbld', 00:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:58 INFO - 'MOZ_NO_REMOTE': '1', 00:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:58 INFO - 'NO_EM_RESTART': '1', 00:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:58 INFO - 'PWD': '/builds/slave/test', 00:54:58 INFO - 'SHELL': '/bin/bash', 00:54:58 INFO - 'SHLVL': '1', 00:54:58 INFO - 'TERM': 'linux', 00:54:58 INFO - 'TMOUT': '86400', 00:54:58 INFO - 'USER': 'cltbld', 00:54:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:58 INFO - '_': '/tools/buildbot/bin/python'} 00:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:58 INFO - Downloading/unpacking jsonschema==2.5.1 00:54: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 00:54: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 00:54: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 00:54: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 00:55:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:55:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:55: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 00:55: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 00:55: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 00:55: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 00:55:00 INFO - Downloading functools32-3.2.3-2.tar.gz 00:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:55:00 INFO - warning: no files found matching '*.txt' 00:55:00 INFO - no previously-included directories found matching 'build' 00:55:00 INFO - no previously-included directories found matching 'dist' 00:55:00 INFO - no previously-included directories found matching '.git*' 00:55:00 INFO - Installing collected packages: jsonschema, functools32 00:55:00 INFO - Running setup.py install for functools32 00:55:00 INFO - warning: no files found matching '*.txt' 00:55:00 INFO - no previously-included directories found matching 'build' 00:55:00 INFO - no previously-included directories found matching 'dist' 00:55:00 INFO - no previously-included directories found matching '.git*' 00:55:00 INFO - Successfully installed jsonschema functools32 00:55:00 INFO - Cleaning up... 00:55:00 INFO - Return code: 0 00:55:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55: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')]} 00:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55: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', '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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:55: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 functools32==3.2.3-2 00:55:00 INFO - Using env: {'DISPLAY': ':0', 00:55:00 INFO - 'HOME': '/home/cltbld', 00:55:00 INFO - 'LANG': 'en_US.UTF-8', 00:55:00 INFO - 'LANGUAGE': 'en_US:en', 00:55:00 INFO - 'LOGNAME': 'cltbld', 00:55:00 INFO - 'MAIL': '/var/mail/cltbld', 00:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:00 INFO - 'MOZ_NO_REMOTE': '1', 00:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:00 INFO - 'NO_EM_RESTART': '1', 00:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:00 INFO - 'PWD': '/builds/slave/test', 00:55:00 INFO - 'SHELL': '/bin/bash', 00:55:00 INFO - 'SHLVL': '1', 00:55:00 INFO - 'TERM': 'linux', 00:55:00 INFO - 'TMOUT': '86400', 00:55:00 INFO - 'USER': 'cltbld', 00:55:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:00 INFO - '_': '/tools/buildbot/bin/python'} 00:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:55:00 INFO - Cleaning up... 00:55:00 INFO - Return code: 0 00:55:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55: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')]} 00:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55: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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55: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 00:55: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 00:55:00 INFO - Using env: {'DISPLAY': ':0', 00:55:00 INFO - 'HOME': '/home/cltbld', 00:55:00 INFO - 'LANG': 'en_US.UTF-8', 00:55:00 INFO - 'LANGUAGE': 'en_US:en', 00:55:00 INFO - 'LOGNAME': 'cltbld', 00:55:00 INFO - 'MAIL': '/var/mail/cltbld', 00:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:00 INFO - 'MOZ_NO_REMOTE': '1', 00:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:00 INFO - 'NO_EM_RESTART': '1', 00:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:00 INFO - 'PWD': '/builds/slave/test', 00:55:00 INFO - 'SHELL': '/bin/bash', 00:55:00 INFO - 'SHLVL': '1', 00:55:00 INFO - 'TERM': 'linux', 00:55:00 INFO - 'TMOUT': '86400', 00:55:00 INFO - 'USER': 'cltbld', 00:55:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:00 INFO - '_': '/tools/buildbot/bin/python'} 00:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:00 INFO - Downloading/unpacking blobuploader==1.2.4 00:55: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 00:55: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 00:55: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 00:55: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 00:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:55:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:55:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 INFO - Downloading docopt-0.6.1.tar.gz 00:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:55:02 INFO - Installing collected packages: blobuploader, requests, docopt 00:55:02 INFO - Running setup.py install for blobuploader 00:55:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:55:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:55:02 INFO - Running setup.py install for requests 00:55:02 INFO - Running setup.py install for docopt 00:55:03 INFO - Successfully installed blobuploader requests docopt 00:55:03 INFO - Cleaning up... 00:55:03 INFO - Return code: 0 00:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:03 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55:03 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 00:55:03 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 00:55:03 INFO - Using env: {'DISPLAY': ':0', 00:55:03 INFO - 'HOME': '/home/cltbld', 00:55:03 INFO - 'LANG': 'en_US.UTF-8', 00:55:03 INFO - 'LANGUAGE': 'en_US:en', 00:55:03 INFO - 'LOGNAME': 'cltbld', 00:55:03 INFO - 'MAIL': '/var/mail/cltbld', 00:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:03 INFO - 'MOZ_NO_REMOTE': '1', 00:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:03 INFO - 'NO_EM_RESTART': '1', 00:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:03 INFO - 'PWD': '/builds/slave/test', 00:55:03 INFO - 'SHELL': '/bin/bash', 00:55:03 INFO - 'SHLVL': '1', 00:55:03 INFO - 'TERM': 'linux', 00:55:03 INFO - 'TMOUT': '86400', 00:55:03 INFO - 'USER': 'cltbld', 00:55:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:03 INFO - '_': '/tools/buildbot/bin/python'} 00:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:03 INFO - Running setup.py (path:/tmp/pip-nqlnFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:03 INFO - Running setup.py (path:/tmp/pip-0dGE4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:03 INFO - Running setup.py (path:/tmp/pip-1Rn_Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:03 INFO - Running setup.py (path:/tmp/pip-fRr6NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:03 INFO - Running setup.py (path:/tmp/pip-qA8l4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:03 INFO - Running setup.py (path:/tmp/pip-yxfHLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:03 INFO - Running setup.py (path:/tmp/pip-PQ1o5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:03 INFO - Running setup.py (path:/tmp/pip-a3xpOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:03 INFO - Running setup.py (path:/tmp/pip-fx4cON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:03 INFO - Running setup.py (path:/tmp/pip-sL9nRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:04 INFO - Running setup.py (path:/tmp/pip-sUDdRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:04 INFO - Running setup.py (path:/tmp/pip-0NIvr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:04 INFO - Running setup.py (path:/tmp/pip-ToWFEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:04 INFO - Running setup.py (path:/tmp/pip-c2rYzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:04 INFO - Running setup.py (path:/tmp/pip-WWvhya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:04 INFO - Running setup.py (path:/tmp/pip-j4Tjw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:04 INFO - Running setup.py (path:/tmp/pip-Uqfxi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:55:04 INFO - Running setup.py install for manifestparser 00:55:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozcrash 00:55:04 INFO - Running setup.py install for mozdebug 00:55:04 INFO - Running setup.py install for mozdevice 00:55:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozfile 00:55:05 INFO - Running setup.py install for mozhttpd 00:55:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozinfo 00:55:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozInstall 00:55:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozleak 00:55:05 INFO - Running setup.py install for mozlog 00:55:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for moznetwork 00:55:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozprocess 00:55:05 INFO - Running setup.py install for mozprofile 00:55:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozrunner 00:55:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozscreenshot 00:55:06 INFO - Running setup.py install for moztest 00:55:06 INFO - Running setup.py install for mozversion 00:55:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:55:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:55:06 INFO - Cleaning up... 00:55:06 INFO - Return code: 0 00:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:06 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55:06 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 00:55:06 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 00:55:06 INFO - Using env: {'DISPLAY': ':0', 00:55:06 INFO - 'HOME': '/home/cltbld', 00:55:06 INFO - 'LANG': 'en_US.UTF-8', 00:55:06 INFO - 'LANGUAGE': 'en_US:en', 00:55:06 INFO - 'LOGNAME': 'cltbld', 00:55:06 INFO - 'MAIL': '/var/mail/cltbld', 00:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:06 INFO - 'MOZ_NO_REMOTE': '1', 00:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:06 INFO - 'NO_EM_RESTART': '1', 00:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:06 INFO - 'PWD': '/builds/slave/test', 00:55:06 INFO - 'SHELL': '/bin/bash', 00:55:06 INFO - 'SHLVL': '1', 00:55:06 INFO - 'TERM': 'linux', 00:55:06 INFO - 'TMOUT': '86400', 00:55:06 INFO - 'USER': 'cltbld', 00:55:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:06 INFO - '_': '/tools/buildbot/bin/python'} 00:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:06 INFO - Running setup.py (path:/tmp/pip-kDs1GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:06 INFO - Running setup.py (path:/tmp/pip-bEjHnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:06 INFO - Running setup.py (path:/tmp/pip-ebYzQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:06 INFO - Running setup.py (path:/tmp/pip-Pw8qy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:06 INFO - Running setup.py (path:/tmp/pip-bSwSri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:06 INFO - Running setup.py (path:/tmp/pip-TgeEh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55: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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:06 INFO - Running setup.py (path:/tmp/pip-qFVU4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:07 INFO - Running setup.py (path:/tmp/pip-Xb_QPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:07 INFO - Running setup.py (path:/tmp/pip-F17yGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:07 INFO - Running setup.py (path:/tmp/pip-FnpxHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:07 INFO - Running setup.py (path:/tmp/pip-xmoj_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:07 INFO - Running setup.py (path:/tmp/pip-VG_O0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:07 INFO - Running setup.py (path:/tmp/pip-dFcVfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:07 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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:07 INFO - Running setup.py (path:/tmp/pip-3NH9nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55: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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:07 INFO - Running setup.py (path:/tmp/pip-VFYxO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55: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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:07 INFO - Running setup.py (path:/tmp/pip-Zdl9Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55: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)) 00:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:07 INFO - Running setup.py (path:/tmp/pip-3NC0ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:55: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 00:55: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 00:55: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 00:55: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 00:55:08 INFO - Downloading blessings-1.6.tar.gz 00:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:55:08 INFO - Installing collected packages: blessings 00:55:08 INFO - Running setup.py install for blessings 00:55:09 INFO - Successfully installed blessings 00:55:09 INFO - Cleaning up... 00:55:09 INFO - Return code: 0 00:55:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:55:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:09 INFO - Reading from file tmpfile_stdout 00:55:09 INFO - Current package versions: 00:55:09 INFO - argparse == 1.2.1 00:55:09 INFO - blessings == 1.6 00:55:09 INFO - blobuploader == 1.2.4 00:55:09 INFO - docopt == 0.6.1 00:55:09 INFO - functools32 == 3.2.3-2 00:55:09 INFO - jsonschema == 2.5.1 00:55:09 INFO - manifestparser == 1.1 00:55:09 INFO - mozInstall == 1.13 00:55:09 INFO - mozcrash == 1.0 00:55:09 INFO - mozdebug == 0.1 00:55:09 INFO - mozdevice == 0.51 00:55:09 INFO - mozfile == 1.2 00:55:09 INFO - mozhttpd == 0.7 00:55:09 INFO - mozinfo == 0.10 00:55:09 INFO - mozleak == 0.1 00:55:09 INFO - mozlog == 3.5 00:55:09 INFO - moznetwork == 0.27 00:55:09 INFO - mozprocess == 0.25 00:55:09 INFO - mozprofile == 0.28 00:55:09 INFO - mozrunner == 6.13 00:55:09 INFO - mozscreenshot == 0.1 00:55:09 INFO - mozsystemmonitor == 0.3 00:55:09 INFO - moztest == 0.8 00:55:09 INFO - mozversion == 1.4 00:55:09 INFO - psutil == 3.1.1 00:55:09 INFO - requests == 1.2.3 00:55:09 INFO - wsgiref == 0.1.2 00:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:09 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55:09 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 00:55:09 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 00:55:09 INFO - Using env: {'DISPLAY': ':0', 00:55:09 INFO - 'HOME': '/home/cltbld', 00:55:09 INFO - 'LANG': 'en_US.UTF-8', 00:55:09 INFO - 'LANGUAGE': 'en_US:en', 00:55:09 INFO - 'LOGNAME': 'cltbld', 00:55:09 INFO - 'MAIL': '/var/mail/cltbld', 00:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:09 INFO - 'MOZ_NO_REMOTE': '1', 00:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:09 INFO - 'NO_EM_RESTART': '1', 00:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:09 INFO - 'PWD': '/builds/slave/test', 00:55:09 INFO - 'SHELL': '/bin/bash', 00:55:09 INFO - 'SHLVL': '1', 00:55:09 INFO - 'TERM': 'linux', 00:55:09 INFO - 'TMOUT': '86400', 00:55:09 INFO - 'USER': 'cltbld', 00:55:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:09 INFO - '_': '/tools/buildbot/bin/python'} 00:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55: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)) 00:55:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:55: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 00:55: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 00:55: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 00:55: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 00:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:55: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)) 00:55: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)) 00:55:10 INFO - Installing collected packages: simplejson 00:55:10 INFO - Running setup.py install for simplejson 00:55:10 INFO - building 'simplejson._speedups' extension 00:55: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 00:55: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 00:55:11 INFO - Successfully installed simplejson 00:55:11 INFO - Cleaning up... 00:55:11 INFO - Return code: 0 00:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55: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')]} 00:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55: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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', '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 00:55: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 00:55: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 00:55:11 INFO - Using env: {'DISPLAY': ':0', 00:55:11 INFO - 'HOME': '/home/cltbld', 00:55:11 INFO - 'LANG': 'en_US.UTF-8', 00:55:11 INFO - 'LANGUAGE': 'en_US:en', 00:55:11 INFO - 'LOGNAME': 'cltbld', 00:55:11 INFO - 'MAIL': '/var/mail/cltbld', 00:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:11 INFO - 'MOZ_NO_REMOTE': '1', 00:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:11 INFO - 'NO_EM_RESTART': '1', 00:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:11 INFO - 'PWD': '/builds/slave/test', 00:55:11 INFO - 'SHELL': '/bin/bash', 00:55:11 INFO - 'SHLVL': '1', 00:55:11 INFO - 'TERM': 'linux', 00:55:11 INFO - 'TMOUT': '86400', 00:55:11 INFO - 'USER': 'cltbld', 00:55:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:11 INFO - '_': '/tools/buildbot/bin/python'} 00:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:55:11 INFO - Cleaning up... 00:55:11 INFO - Return code: 0 00:55:11 INFO - Running post-action listener: _resource_record_post_action 00:55:11 INFO - Running post-action listener: _start_resource_monitoring 00:55:11 INFO - Starting resource monitoring. 00:55:11 INFO - [mozharness: 2017-09-14 07:55:11.998676Z] Finished create-virtualenv step (success) 00:55:11 INFO - [mozharness: 2017-09-14 07:55:11.999182Z] Running install step. 00:55:11 INFO - Running pre-action listener: _resource_record_pre_action 00:55:11 INFO - Running main action method: install 00:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:12 INFO - Reading from file tmpfile_stdout 00:55:12 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:55:12 INFO - Reading from file tmpfile_stdout 00:55:12 INFO - Output received: 00:55:12 INFO - Usage: mozinstall [options] installer 00:55:12 INFO - Options: 00:55:12 INFO - -h, --help show this help message and exit 00:55:12 INFO - -d DEST, --destination=DEST 00:55:12 INFO - Directory to install application into. [default: 00:55:12 INFO - "/builds/slave/test"] 00:55:12 INFO - --app=APP Application being installed. [default: firefox] 00:55:12 INFO - mkdir: /builds/slave/test/build/application 00:55:12 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'] 00:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:55:30 INFO - Reading from file tmpfile_stdout 00:55:30 INFO - Output received: 00:55:30 INFO - /builds/slave/test/build/application/firefox/firefox 00:55:30 INFO - Running post-action listener: _resource_record_post_action 00:55:30 INFO - [mozharness: 2017-09-14 07:55:30.104494Z] Finished install step (success) 00:55:30 INFO - [mozharness: 2017-09-14 07:55:30.104746Z] Running setup-mitmproxy step. 00:55:30 INFO - Running pre-action listener: _resource_record_pre_action 00:55:30 INFO - Running main action method: setup_mitmproxy 00:55:30 INFO - Skipping: mitmproxy is not required 00:55:30 INFO - Running post-action listener: _resource_record_post_action 00:55:30 INFO - [mozharness: 2017-09-14 07:55:30.105971Z] Finished setup-mitmproxy step (success) 00:55:30 INFO - [mozharness: 2017-09-14 07:55:30.106193Z] Running run-tests step. 00:55:30 INFO - Running pre-action listener: _resource_record_pre_action 00:55:30 INFO - Running pre-action listener: _set_gcov_prefix 00:55:30 INFO - Running main action method: run_tests 00:55:30 WARNING - Try message not found. 00:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:55:30 INFO - Python 2.7.3 00:55:30 INFO - Return code: 0 00:55:30 INFO - grabbing minidump binary from tooltool 00:55:30 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')]} 00:55:30 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 0x11a4090>, '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 0x11a4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:55:30 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 00:55:30 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 00:55:30 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 00:55:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:30 INFO - Return code: 0 00:55:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:55:30 INFO - ENV: RUST_BACKTRACE is now full 00:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 00:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 00:55:30 INFO - Using env: {'DISPLAY': ':0', 00:55:30 INFO - 'HOME': '/home/cltbld', 00:55:30 INFO - 'LANG': 'en_US.UTF-8', 00:55:30 INFO - 'LANGUAGE': 'en_US:en', 00:55:30 INFO - 'LOGNAME': 'cltbld', 00:55:30 INFO - 'MAIL': '/var/mail/cltbld', 00:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:30 INFO - 'MOZ_NO_REMOTE': '1', 00:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:30 INFO - 'NO_EM_RESTART': '1', 00:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:30 INFO - 'PWD': '/builds/slave/test', 00:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:30 INFO - 'RUST_BACKTRACE': 'full', 00:55:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:30 INFO - 'SHELL': '/bin/bash', 00:55:30 INFO - 'SHLVL': '1', 00:55:30 INFO - 'TERM': 'linux', 00:55:30 INFO - 'TMOUT': '86400', 00:55:30 INFO - 'USER': 'cltbld', 00:55:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:30 INFO - '_': '/tools/buildbot/bin/python'} 00:55:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 00:55:30 INFO - mozversion application_buildid: 20170914070342 00:55:30 INFO - mozversion application_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:30 INFO - mozversion application_display_name: Nightly 00:55:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:30 INFO - mozversion application_name: Firefox 00:55:30 INFO - mozversion application_remotingname: firefox 00:55:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:55:30 INFO - mozversion application_vendor: Mozilla 00:55:30 INFO - mozversion application_version: 57.0a1 00:55:30 INFO - mozversion platform_buildid: 20170914070342 00:55:30 INFO - mozversion platform_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:55:30 INFO - mozversion platform_version: 57.0a1 00:55:30 INFO - using testdate: 1505375730 00:55:30 INFO - actual date: 1505375730 00:55:30 INFO - starting webserver on 'localhost:59895' 00:55:30 INFO - SUITE-START | Running 2 tests 00:55:30 INFO - TEST-START | dromaeo_css 00:55:30 INFO - Initialising browser for dromaeo_css test... 00:55:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59895/getInfo.html -profile /tmp/tmpKHAaCW/profile 00:55:30 INFO - TEST-INFO | started process 5688 (/builds/slave/test/build/application/firefox/firefox http://localhost:59895/getInfo.html) 00:55:35 INFO - TEST-INFO | 5688: exit 0 00:55:36 INFO - Browser initialized. 00:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 00:55:36 INFO - Using env: {'DISPLAY': ':0', 00:55:36 INFO - 'HOME': '/home/cltbld', 00:55:36 INFO - 'JSGC_DISABLE_POISONING': '1', 00:55:36 INFO - 'LANG': 'en_US.UTF-8', 00:55:36 INFO - 'LANGUAGE': 'en_US:en', 00:55:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:55:36 INFO - 'LOGNAME': 'cltbld', 00:55:36 INFO - 'MAIL': '/var/mail/cltbld', 00:55:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:36 INFO - 'MOZ_CRASHREPORTER': '1', 00:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:55:36 INFO - 'MOZ_NO_REMOTE': '1', 00:55:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:36 INFO - 'NO_EM_RESTART': '1', 00:55:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:36 INFO - 'PWD': '/builds/slave/test', 00:55:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:36 INFO - 'RUST_BACKTRACE': 'full', 00:55:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:36 INFO - 'SHELL': '/bin/bash', 00:55:36 INFO - 'SHLVL': '1', 00:55:36 INFO - 'TERM': 'linux', 00:55:36 INFO - 'TMOUT': '86400', 00:55:36 INFO - 'USER': 'cltbld', 00:55:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 00:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:36 INFO - '_': '/tools/buildbot/bin/python'} 00:55:36 INFO - TEST-INFO | started process 5922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHAaCW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:36 INFO - PID 5922 | 00:55:36 INFO - PID 5922 | (/builds/slave/test/build/application/firefox/firefox:5971): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:55:36 INFO - PID 5922 | 00:55:47 INFO - PID 5922 | RSS: Main: 172843008 00:55:47 INFO - PID 5922 | 00:58:44 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59895/tests/dromaeo/cssquery-ext.html) 00:58:45 INFO - PID 5922 | RSS: Main: 174194688 00:58:45 INFO - PID 5922 | 01:01:46 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-ext.html (next: http://localhost:59895/tests/dromaeo/cssquery-jquery.html) 01:01:47 INFO - PID 5922 | RSS: Main: 170209280 01:01:47 INFO - PID 5922 | 01:04:49 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59895/tests/dromaeo/cssquery-mootools.html) 01:04:49 INFO - PID 5922 | RSS: Main: 174137344 01:04:49 INFO - PID 5922 | 01:07:51 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59895/tests/dromaeo/cssquery-prototype.html) 01:07:52 INFO - PID 5922 | RSS: Main: 173297664 01:07:52 INFO - PID 5922 | 01:10:55 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59895/tests/dromaeo/cssquery-yui.html) 01:10:55 INFO - PID 5922 | RSS: Main: 173813760 01:10:55 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | Cycle 1(1): loaded http://localhost:59895/tests/dromaeo/cssquery-yui.html (next: http://localhost:59895/tests/dromaeo/cssquery-dojo.html) 01:13:57 INFO - PID 5922 | RSS: Main: 176947200 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | __start_tp_report 01:13:57 INFO - PID 5922 | _x_x_mozilla_page_load 01:13:57 INFO - PID 5922 | _x_x_mozilla_page_load_details 01:13:57 INFO - PID 5922 | |i|pagename|runs| 01:13:57 INFO - PID 5922 | |0;dojo.html;3152.921176970574;3153.700398462146;3177.904662860114;3195.3609278144363;3211.6467188609263;6305.716242769075;6345.7144428500715;6355;6392.360763923605;6403;6220.751169953208;6320.304766475684;6329.968350158243;6335.841603959903;6358.046293056044;5809.099589563624;5929.911051334234;5963.522918166536;5974.970125149368;5990.580659353847;5940.643561386309;5981.252343457068;5986;6012.789552365668;6031.306399764039;1260.434467594633;5388.7305634718305;5787.855303617401;5790.594658373915;5966.67183304918;5844.561657875676;5862.648241105505;5924.822255332347;5927.881442371128;5935.10973353996;5833.970830145822;5837.124431335291;5897.203877476529;5908.4091590841;5913.113033045078;6213.471854892295;6287.96856015717;6371.553991220617;6443.097966284724;6445.291017988017;6823.317668233187;6827.863442731167;6913.170419549636;6916.377526022632;6945.652717364112;6769.3907548320885;6851.520393572452;6863.725450981955;6865.210500792423;6872.450203983669;6239.875202495925;6322.9051564226575;6419.6790160492255;6421.550491465599;6443.420092191725;7069.399101076466;7143.535670181422;7149.60677162761;7160.10498687664;7173.713051477883;6719.092922455504;6721.361470660279;6749.2238392584495;6819.283975182633;6829.829254268584;6702.731890724414;6760.290169532227;6808.455323574201;6850.554713943578;6939.271376505495;6747.325267473311;6794.014867844135;6818.352256535622;6828.965855170792;6840.179178498513;6841.863162736817;6919.688614012382;6924.757633482804;6929.826754331182;6947.235804061549;5151.407588127413;5223.712695801767;5228.163493840967;5236.476352364809;5280.841574752763;4612.515685852937;4636.211843986531;4649.907271791127;4654.976725116353;4655.813767449332;5875.941240587625;5883.14694369314;5885.205497257815;5971.910421343683;5978.1929439525975;6925.411340036053;6951.548149370275;6999.8600027999155;7012.964935175291;7017.912223605349;5926.140709597084;5930.762769489258;5981.252343457068;6013.368596297326;6017.669028203491;5751.568632352591;5830.038043722739;5860.912086318709;5893.057110862242;5965.701714914237;6623.458039420826;6634.668266586651;6660.200775906922;6667.533272670964;6669.833254168685;6871.484638652221;6943.375096241362;6947;6961.477889158232;6961.7215311389;6596.241432235354;6625.370589793962;6695.732170713117;6698.698558564779;6731;6670.599764014175;6726.058351830649;6735.393814556714;6783.05037294789;6794.83012924661;6893.655317234218;6974.442044636518;6987.091678081817;6994.6852391643515;7007.089078419773;6645.634490103091;6646.501512386687;6659.900101498384;6701.832454188684;6759.5606285591275;6592.736290548516;6608.570442921195;6646.435053020354;6649.46804255668;6662.533622646368;6559.278479367361;6624.205095388585;6625.734970601315;6635.734570617315;6670.699818508276;6669.899951500634;6681.665916704048;6703.430208432338;6741.662916854039;6743.325667433218;6316.968415157895;6423.29343772194;6481.222253329631;6490.091387205701;6584.736610535525 01:13:57 INFO - PID 5922 | |1;ext.html;806.0931452116369;845.0873057098335;861.7888617288766;862.1593945902745;876.3733930239879;40307.79846100769;40962.59037409625;41193;41245.793771031174;41293.58706412939;36815.26369472609;37019.259614807685;40438.19123617526;40520.797396013055;40690;7683.078030636331;7795.454318197729;7813.218678132198;7834.764957051298;7850.528968261894;7651.234876512332;7734.961325193366;7743.148253692089;7748.7675369739;7767.495112817677;7745.612719364038;7768.57272849993;7813.9609301953415;7821.139674635786;7832.647530861096;7755.108162561293;7769.494982826126;7772.7279545216215;7788.415868809862;7790.766277011699;7603.5057721248495;7663.042119735033;7663.885041724378;7667.118281397599;7667.961660191719;36210;36289.45565816515;36400.63599363999;36408;36461.45307820385;3484.390231709466;3527.1358517163203;3528.100334414708;3528.558930133733;3530.6645868642436;30957.071287861174;31071.68928310733;31098;31117.377652446823;31182.376352472824;5053.267276244961;5203.765830537635;5224.529792318672;5250.396204436501;5260.526552610245;185262;188709;191396;191652;199493.00253498784;48142.75928620405;48470.515294847304;48742.5125748738;48805;48977.75511122493;50440.243396349084;50876;50937;50940;51153.74423127861;15779.921100394655;15820.288087036111;15926.124063176636;15935.920320398556;16120.355185792672;13316.667083322995;13355.666108347368;13364.866351336363;13372.598822035354;13373.66565835862;12561.371931403393;12715.046371522172;12828.486860525662;12915.612531624067;12964;5070.442251352349;5119.462456442095;5142.228665700175;5171.2501687255135;5315.787368505294;974.6978436684509;989.8762654668167;992.6029588164647;1009.9192064634958;1012.2610494339174;22360.32919012432;22453.663195052086;22472;22568.322950311518;22681.88659056694;1108.2906939558688;1112.5660992213043;1118.3904771899333;1120.0927248928394;1126.0822429719751;11744.706382340339;11922.701932451759;11970.940145299392;11972.700682483008;11983.820242696367;224887;226482;226574;226596;226648;50015;50103;50188.749056254484;50190;50319;1409.8942579306388;1441.4162264282982;1453.3314675249292;1454.2074569359513;1457.3733294683177;22081.447963801034;22448.32655020352;22526.66210006884;22800.201992930168;22848.885755571115;36653.08367290733;36955;36976.44535332026;37000;37015.8149209263;186969;188314;188621;188932;189181;33828.66171338255;33840.49239261364;34979.65020349764;35314.82342588373;35642.821785890905;44446.11107777762;45437.54562454333;45460.090798184516;45669;45735.54264457313;32716.509252360756;32776;32878.34243315073;33039.174020648716;33141.83429082839;32273.677263228008;33206.16984575405;33215.66784332126;33444.498332525516;33797;36099;37475.06312342213;37561.4365784508;37564.436533452565;37618;32288.83855580801;32359.676403235666;32391.676083238865;32875.835620821745;32960.340793184485;23019.65470517977;23234.3029709109;23238.1866634667;23240.18659346915;23856.16503422372 01:13:57 INFO - PID 5922 | |2;jquery.html;550.468797610306;556.4935908323426;567.4779203133118;577.1515871668647;586.1910563422477;21680.674789878143;22566.43583910403;22649.773502264972;22682.65976010359;22711.659325110137;23621;24442.3889402765;24795.50408991819;24910.25269241921;25142.497150056988;6455.838604034901;6538.6076835389795;6566.409023187912;6570.047343135243;6571.44142747867;6150.815475535741;6447.516436267299;6495.155629768124;6551.082848401227;6553.246376666697;6335.208098987627;6335.493160547145;6338.461230795388;6340.968295158517;6366.331535188808;6259.906101408483;6310.242770867525;6334.049892516114;6340;6341.651209183493;5676;5852.824415267549;5864.472197502245;5872.647641141502;5876.3242227144;28330.85834570814;28373.432531349463;28866.85566572175;28917;29026.12921612355;2014.5567975045467;2041.9183232670823;2045.222815330165;2059.4130672758192;2066.173530587762;18556.536086597807;18847.151878165514;18886.811131888644;18974.05129743521;19151.616967660568;2377.476955069882;2436.5248776488593;2443.438009257863;2451.509698060377;2488.7884529814987;123869;130109.34945325307;131242;141290;145647.99999999895;20100.195992160443;20270.69593956092;21234.362969110953;21751.78248217529;21827.345179644635;41672;42023.57976420258;42067.36898946518;42146;42240.366394504104;11572.94213528927;11641.6507504775;11655.358955257543;11661.35862527569;11711.355875426763;9731.172850307661;9883.802323953481;9919.80160396788;9952.452615106238;10015.949920250352;10604.681859544226;10778.514966826511;11022.669319920415;11033.724156896142;11345.432728363714;3718.8512459501317;3729.254149170177;4208.600182982612;4318;4438.312061630452;927.4620719982394;944.15026476172;954.7994921066515;960.4093482508207;963.3689933093834;18837;19097.713534296996;19310.420687379403;19323.51691207731;19545.315913942944;997.7605374710017;1019.2457581389718;1029.7734498410339;1032.3289861590026;1033.6950599573145;10479.476026198812;10553.947230263799;10595.523201455953;10699.037086662081;10753.193510486744;462819;479883;486771;500060;504983;111193;112038.43980780045;114522.13694657534;115123.42438287755;116818;1025.4206373399006;1059.2638116509106;1146.8623765148068;1180.8701042885275;1203.5246077799395;19468.123934423267;19625.214991400186;19858.70211946793;19896.104675289935;20408.89795551013;55382.44617553934;56311.71844140753;56513.15230271467;57712;58306;68053.31946680667;68405.65797170982;69907.65046174737;71327;72436.63781681057;19629.50926226856;19896.90051549733;19914.203431862563;20003.199872005538;20041.799582003994;22298.442538936655;22408.887955560116;22459.764712940945;22508.324750257518;22524.662130067733;17662.116894155497;17983.820161798216;18007.81992180114;18017.189226484577;18023.72964405509;15291.388344466097;16075.19624018771;16127.75808362852;16162.515124546282;16620.501384958472;18009.909950450165;18281.268749250412;18397.080145992913;18460.07699615041;18609.348672796386;19330.710039349702;19488.317908873123;19492.31776887802;19533.609327813647;19759.110840012523;17774.644507109526;17817.643647127243;17836.197371118073;18108.09459526992;18123.45629631113 01:13:57 INFO - PID 5922 | |3;mootools.html;1333.186756078792;1367.432515506065;1383.2806940390997;1385.3419625677805;1389.5622878793174;14808.259587020646;15378.384864605416;15467.845321546782;15478.845211547881;15491.147986860718;14880.553583392488;14943.551693449186;14994.625134371647;14998.100113993169;14998.175100369475;2614.7254538273446;2752.0230318237036;2756.324700448383;2760.4755096531694;2765.25338158697;2786.8049236553447;2789;2815.7184281571886;2816.8591570421395;2828.688844227144;2672;2742.931426714328;2854.029629925825;2858.899938502153;2861.370498490329;2791.734785195403;2795.580662900561;2843.644544431946;2854.9999999999895;2857.6142220800134;2767.1975127213086;2796.300924768808;2801.047643801097;2803.6074949507083;2835.277004363895;14579.92710036443;14616.123032618078;14843.480478183212;14883.107013579112;14931.25343732809;7990.520568765893;8265;8287.337013038943;8293.170682931719;8301.29438997686;5333.919991200135;5439.972800136014;5497.835064948058;5522.641028333145;5605.887882242332;1880.069365664005;1892.7728672559244;1894.6684330242153;1936.4868309897888;1956.4032969944162;26453.867730661415;27129.593056104175;27133.728662713318;27139;27157.86421067882;6969.721211151497;7035.366816986496;7222.819429514199;7312.268773122645;7426.331630153312;20350;20369.490762730755;20413.081411336527;20448.59102817965;20488.282910098074;8087.959560202161;8356.498610083414;8377.748667539983;8381.16188381157;8389.328853691812;7299.19708832028;7447.329740323397;7484.663190156456;7485.326320631169;7497.437692173109;5510.283663123768;5692.089265717465;5777.537796976232;5799;5840.123981402823;1687.2576066530687;1709.7777288952357;1753.395078697847;1815.5370380552874;1856.1925562380409;868.6134670071757;877.4033657113224;904.2359206470653;916.8074704312036;917.064594114;8424.157584241526;8438.789030274169;8440.240378365976;8497.66009359631;8564.61459234336;714.6962540920089;725.6516871901517;725.7423614616735;732.1580182789834;801.1227705662291;4859.708417494961;5060.342155519759;5102.5662818660085;5157.277981082651;5206.921896171561;21288.574228515343;21406;21623.56752864934;22162.445938851335;22197.11211551552;21213.681794773092;21697.240596579042;21833.67249491259;21855.562888742137;21917.671234931488;10654.254202205771;11300.491477883515;11330.376829274304;11357;11393.145514086476;8475.533845638549;8486.575671216538;8554.78613034679;8598.484090954562;8614.956925215334;17972.370967016093;18301.26794928188;18513.72229416587;18534.351297705056;18785.248590056246;19151.808481915003;19309;19330.13014414383;19490.90254548718;19686.212551497778;11638;11662.300261984308;11679.182457228253;11705.297682139098;11710.297382157098;13555.525556605471;13885.72228555403;14016.369263383376;14019.369128389042;14031.228282444155;10813.729656758644;10851.511681974172;10954.287971281841;11030.22788404804;11300.717482063013;10322.741931451774;10507.369557826554;10644.733881653021;10705.464726763475;10989.450527473755;9329.673461428818;9366.859497107685;9431.868175818945;9461.148496635336;9467.431954082776;6769.153855768029;6864.862702746017;6941.947341084318;7007.649617519001;7043;6954.478414119062;7016.26329235423;7055.929440705528;7057.153141623038;7076.752313668997 01:13:57 INFO - PID 5922 | |4;prototype.html;498.0674201281864;502.97188199429837;518.8754698872272;521.2467983763462;522.2479629333759;6278.874422511547;6340.429361357477;6378.075179099033;6379.840503987402;6390.744370225197;6230.283517395501;6260.937390626093;6291.307956124822;6292.5595208335435;6303.590266632666;5201.68789872607;5203.609729270301;5211.765470553815;5216.157194329081;5221.269022336875;4846.636502262327;4972.900541989158;5167.276581278624;5178.482151784829;5208.765605547759;4950.480199579047;4951.727654978975;4954.083494553501;4962.156433406311;4973.5772459341;4932.654714169991;4939.580135688435;4957.256411538262;4972.0055988802205;4975.477574854624;4428.402165707653;4442.244818380883;4771.976140119312;4851.975740121312;4858.805647774085;6163.87672246557;6167.044108163242;6200.565960382775;6218.782342617987;6224.190855188842;5825.155352473867;5868.853278668067;5929.644221346733;5956.880862382772;5980.953333166678;6592.80221593353;6601.504887133484;6607.9669601651685;6621.437177839889;6627.1716035495565;5049.873753156164;5262.368515778093;5282.894342113136;5306.416294207634;5316.441773613792;6720.252734289071;6739.359760822714;6801;6890.8621827563165;6912.930870691279;5337.653052551572;5368.677879327252;5402.567794576425;5404.83785486436;5418.810341638103;5386.380566234855;5464.371597266365;5467.234587157801;5469;5483.588730845203;5836.182934389189;5873.295204575393;5887.676177810176;5897.174395584621;5916.911246331309;6489.415952564292;6528.278881037763;6549.836254093686;6573.506986975996;6582.3746744059235;1874.3533480949052;1902.1929167291128;1916.2047750183517;1922.7692676878864;1924.6824273994914;1316.6379245707508;1379.661982814217;1408.478862820763;1409.59121854661;1431.8568143185598;5557.138643510262;5562.9443705563235;5563.304586926634;5564.693941833157;5621.381648018714;6403.615783053032;6587.473002159816;6633.303503132198;6647.66761661915;6656.500762442836;5534.446555344514;5536.363318218457;5540.36285827135;5558.416366281483;5587.217789509472;3453.4129198036394;3494.8427320770625;3536.5579302587175;3540.858365665396;3542.628024057437;6421.357864213542;6426.132472116298;6439.7424103035355;6444.548881578338;6451.677416129269;6679.666016699146;6707.396334329934;6742.190937087483;6757.3242675732035;6864.048459162508;6373.139626150503;6374.394432528902;6376.968115159488;6395.904061439175;6428.582142160838;6541.6402097885075;6572.272506909579;6608.240052394036;6638.867222655616;6640.435562977201;6451.903221451588;6550.6069635822005;6601.801945941629;6615.801525954229;6632.081883971037;6360.300366959538;6372.87254254903;6382.723455309049;6412.332793473824;6428.8071357859335;5310.654807437504;5323.441038690882;5323.760430780547;5326.813561525328;5333.359996800409;6336.429721324918;6626.469882409492;6631.834204144935;6671.299513551201;6674.332566743286;6064.818055458343;6430.971044633024;6464.127342808849;6465.288818229897;6470.320616335405;6318.684065796784;6409.166808314889;6429.7749578764515;6444.903326450013;6503.374580987506;6302.243730752339;6320.747170113144;6336.461400780985;6401.615903045832;6432.324605916311;6562.2125344957;6563.3764792344655;6566.9014964776525;6615.900761488485;6623.635700036544;6272.717727702173;6329.272133704683;6355;6384.297727250092;6388.808335749749 01:13:57 INFO - PID 5922 | |5;yui.html;876.6230520876021;911.740154056094;922.9400088994215;928.5078908178667;938.9295802814788;18742.812571874278;19498.317558885443;19566.510837229078;19573.60852782947;19579.804201957977;17483.82516174838;18056.368027119053;18402.907985460086;18442;18463;973.8977407372213;978.021978021978;979.9265055120894;980.083621813603;980.4950450517989;912.2337236721153;937.0957026469456;961.7835986902961;971.1017308989192;977.081543349253;1030.4487099401822;1032.4321623107298;1036.471399586209;1036.7045392063264;1037.8235699930992;1009.535613617733;1033.0960409641564;1037.258360272405;1042.4579218806255;1044.305536818015;709.7019251914209;729.4164668265366;745.9664315105833;746.1568427676744;746.3394895517451;19584.80415195844;19599.510012249666;19810.70283945742;19874;19908.104135313944;21080.472988175265;22049.00779464928;22202.333929982127;22206.777932220633;22229.221977230718;16017.679646407123;16283.348666053344;16479.505614831454;16502.92730972495;16513.91743041289;3804.5814960354337;3814.218085292536;3817.2174704185854;3832.5209348831395;3838.193979264358;145583;145651;146264.26867865698;149257;149885;16986.83013169877;17143.142842857807;17599.64800703979;17601.647967040586;17613.91193044052;30548.54177187344;31379.529307060413;31432.21419464486;31433.37133257322;31449.685503144676;8374.413791034569;8432.873506897402;8467.110953349933;8546.017208021032;8546.743597692079;4172.77049762266;4248.171606536695;4269.487661480643;4277.743335399886;4282.314829627245;5522.696251706115;5638.802641907513;5654.236678048493;5658.405867383948;5670.376258611549;974.1427543761586;978.3493976505545;981.0581841432162;984.8522721591676;985.0691096913348;687.6767919078026;706.1949377709416;710.9431245500348;714.7212587091038;731.1518638379455;11801.40992950349;12077.698057548632;12341.876581234252;12400.31798251105;13077.673058173432;695.3290075077574;705.7812078255757;717.8348979734691;718.9460790440738;718.9820254493679;5526.861828454241;5551.333839939233;5568.470995255444;5577.27495425592;5777.422257774189;115395.42302288603;118657.031883309;126416;127940;130404.3479782595;99578;105386;107466.46266768617;108344.70043319817;112049;95002.524987376;95128.52435737777;98467;100672;101345.49327253316;12426.689332766753;12805.359732013176;12945.741085178432;12998.675033124247;13013.349332533146;42568.5743142577;43101.7844910786;43322.566774333114;44209;45885.31172032489;54931;55995;56433.43566564282;56586;58393;18701.06494675288;19100.71348929795;19229.711554326415;19248.61502769965;19287.228510859968;21029.789702102782;21122.471938201666;21144.682829757872;21209.36371908845;21263.8936805315;18874;19000.144993475602;19094;19171;19193.32823351176;17240.310387584355;17380.826191738426;17388.565285867953;17438.651226975642;17778.46664600064;17464;17547;17613.471595852145;17741.201645926223;17925.19336629881;12452.501899924264;12620;12832.871671283168;12849.87150128524;12963.935180324039;13792;13893.166410015432;13973;14145.858541414866;14288.57134285973 01:13:57 INFO - PID 5922 | __end_tp_report 01:13:57 INFO - PID 5922 | __start_cc_report 01:13:57 INFO - PID 5922 | _x_x_mozilla_cycle_collect,359 01:13:57 INFO - PID 5922 | __end_cc_report 01:13:57 INFO - PID 5922 | __startTimestamp1505376837834__endTimestamp 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | ------- Summary: start ------- 01:13:57 INFO - PID 5922 | Number of tests: 6 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#0] dojo.html Cycles:165 Average:6271.43 Median:6596.24 stddev:870.97 (13.2%) stddev-sans-first:838.58 01:13:57 INFO - PID 5922 | Values: 3152.9 3153.7 3177.9 3195.4 3211.6 6305.7 6345.7 6355.0 6392.4 6403.0 6220.8 6320.3 6330.0 6335.8 6358.0 5809.1 5929.9 5963.5 5975.0 5990.6 5940.6 5981.3 5986.0 6012.8 6031.3 1260.4 5388.7 5787.9 5790.6 5966.7 5844.6 5862.6 5924.8 5927.9 5935.1 5834.0 5837.1 5897.2 5908.4 5913.1 6213.5 6288.0 6371.6 6443.1 6445.3 6823.3 6827.9 6913.2 6916.4 6945.7 6769.4 6851.5 6863.7 6865.2 6872.5 6239.9 6322.9 6419.7 6421.6 6443.4 7069.4 7143.5 7149.6 7160.1 7173.7 6719.1 6721.4 6749.2 6819.3 6829.8 6702.7 6760.3 6808.5 6850.6 6939.3 6747.3 6794.0 6818.4 6829.0 6840.2 6841.9 6919.7 6924.8 6929.8 6947.2 5151.4 5223.7 5228.2 5236.5 5280.8 4612.5 4636.2 4649.9 4655.0 4655.8 5875.9 5883.1 5885.2 5971.9 5978.2 6925.4 6951.5 6999.9 7013.0 7017.9 5926.1 5930.8 5981.3 6013.4 6017.7 5751.6 5830.0 5860.9 5893.1 5965.7 6623.5 6634.7 6660.2 6667.5 6669.8 6871.5 6943.4 6947.0 6961.5 6961.7 6596.2 6625.4 6695.7 6698.7 6731.0 6670.6 6726.1 6735.4 6783.1 6794.8 6893.7 6974.4 6987.1 6994.7 7007.1 6645.6 6646.5 6659.9 6701.8 6759.6 6592.7 6608.6 6646.4 6649.5 6662.5 6559.3 6624.2 6625.7 6635.7 6670.7 6669.9 6681.7 6703.4 6741.7 6743.3 6317.0 6423.3 6481.2 6490.1 6584.7 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#1] ext.html Cycles:180 Average:37096.13 Median:35478.82 stddev:52495.49 (148.0%) stddev-sans-first:52572.03 01:13:57 INFO - PID 5922 | Values: 806.1 845.1 861.8 862.2 876.4 40307.8 40962.6 41193.0 41245.8 41293.6 36815.3 37019.3 40438.2 40520.8 40690.0 7683.1 7795.5 7813.2 7834.8 7850.5 7651.2 7735.0 7743.1 7748.8 7767.5 7745.6 7768.6 7814.0 7821.1 7832.6 7755.1 7769.5 7772.7 7788.4 7790.8 7603.5 7663.0 7663.9 7667.1 7668.0 36210.0 36289.5 36400.6 36408.0 36461.5 3484.4 3527.1 3528.1 3528.6 3530.7 30957.1 31071.7 31098.0 31117.4 31182.4 5053.3 5203.8 5224.5 5250.4 5260.5 185262.0 188709.0 191396.0 191652.0 199493.0 48142.8 48470.5 48742.5 48805.0 48977.8 50440.2 50876.0 50937.0 50940.0 51153.7 15779.9 15820.3 15926.1 15935.9 16120.4 13316.7 13355.7 13364.9 13372.6 13373.7 12561.4 12715.0 12828.5 12915.6 12964.0 5070.4 5119.5 5142.2 5171.3 5315.8 974.7 989.9 992.6 1009.9 1012.3 22360.3 22453.7 22472.0 22568.3 22681.9 1108.3 1112.6 1118.4 1120.1 1126.1 11744.7 11922.7 11970.9 11972.7 11983.8 224887.0 226482.0 226574.0 226596.0 226648.0 50015.0 50103.0 50188.7 50190.0 50319.0 1409.9 1441.4 1453.3 1454.2 1457.4 22081.4 22448.3 22526.7 22800.2 22848.9 36653.1 36955.0 36976.4 37000.0 37015.8 186969.0 188314.0 188621.0 188932.0 189181.0 33828.7 33840.5 34979.7 35314.8 35642.8 44446.1 45437.5 45460.1 45669.0 45735.5 32716.5 32776.0 32878.3 33039.2 33141.8 32273.7 33206.2 33215.7 33444.5 33797.0 36099.0 37475.1 37561.4 37564.4 37618.0 32288.8 32359.7 32391.7 32875.8 32960.3 23019.7 23234.3 23238.2 23240.2 23856.2 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#2] jquery.html Cycles:180 Average:35496.41 Median:22062.89 stddev:81822.41 (370.9%) stddev-sans-first:82009.88 01:13:57 INFO - PID 5922 | Values: 550.5 556.5 567.5 577.2 586.2 21680.7 22566.4 22649.8 22682.7 22711.7 23621.0 24442.4 24795.5 24910.3 25142.5 6455.8 6538.6 6566.4 6570.0 6571.4 6150.8 6447.5 6495.2 6551.1 6553.2 6335.2 6335.5 6338.5 6341.0 6366.3 6259.9 6310.2 6334.0 6340.0 6341.7 5676.0 5852.8 5864.5 5872.6 5876.3 28330.9 28373.4 28866.9 28917.0 29026.1 2014.6 2041.9 2045.2 2059.4 2066.2 18556.5 18847.2 18886.8 18974.1 19151.6 2377.5 2436.5 2443.4 2451.5 2488.8 123869.0 130109.3 131242.0 141290.0 145648.0 20100.2 20270.7 21234.4 21751.8 21827.3 41672.0 42023.6 42067.4 42146.0 42240.4 11572.9 11641.7 11655.4 11661.4 11711.4 9731.2 9883.8 9919.8 9952.5 10015.9 10604.7 10778.5 11022.7 11033.7 11345.4 3718.9 3729.3 4208.6 4318.0 4438.3 927.5 944.2 954.8 960.4 963.4 18837.0 19097.7 19310.4 19323.5 19545.3 997.8 1019.2 1029.8 1032.3 1033.7 10479.5 10553.9 10595.5 10699.0 10753.2 462819.0 479883.0 486771.0 500060.0 504983.0 111193.0 112038.4 114522.1 115123.4 116818.0 1025.4 1059.3 1146.9 1180.9 1203.5 19468.1 19625.2 19858.7 19896.1 20408.9 55382.4 56311.7 56513.2 57712.0 58306.0 68053.3 68405.7 69907.7 71327.0 72436.6 19629.5 19896.9 19914.2 20003.2 20041.8 22298.4 22408.9 22459.8 22508.3 22524.7 17662.1 17983.8 18007.8 18017.2 18023.7 15291.4 16075.2 16127.8 16162.5 16620.5 18009.9 18281.3 18397.1 18460.1 18609.3 19330.7 19488.3 19492.3 19533.6 19759.1 17774.6 17817.6 17836.2 18108.1 18123.5 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#3] mootools.html Cycles:180 Average:9462.28 Median:2762.86 stddev:6811.18 (246.5%) stddev-sans-first:6802.90 01:13:57 INFO - PID 5922 | Values: 1333.2 1367.4 1383.3 1385.3 1389.6 14808.3 15378.4 15467.8 15478.8 15491.1 14880.6 14943.6 14994.6 14998.1 14998.2 2614.7 2752.0 2756.3 2760.5 2765.3 2786.8 2789.0 2815.7 2816.9 2828.7 2672.0 2742.9 2854.0 2858.9 2861.4 2791.7 2795.6 2843.6 2855.0 2857.6 2767.2 2796.3 2801.0 2803.6 2835.3 14579.9 14616.1 14843.5 14883.1 14931.3 7990.5 8265.0 8287.3 8293.2 8301.3 5333.9 5440.0 5497.8 5522.6 5605.9 1880.1 1892.8 1894.7 1936.5 1956.4 26453.9 27129.6 27133.7 27139.0 27157.9 6969.7 7035.4 7222.8 7312.3 7426.3 20350.0 20369.5 20413.1 20448.6 20488.3 8088.0 8356.5 8377.7 8381.2 8389.3 7299.2 7447.3 7484.7 7485.3 7497.4 5510.3 5692.1 5777.5 5799.0 5840.1 1687.3 1709.8 1753.4 1815.5 1856.2 868.6 877.4 904.2 916.8 917.1 8424.2 8438.8 8440.2 8497.7 8564.6 714.7 725.7 725.7 732.2 801.1 4859.7 5060.3 5102.6 5157.3 5206.9 21288.6 21406.0 21623.6 22162.4 22197.1 21213.7 21697.2 21833.7 21855.6 21917.7 10654.3 11300.5 11330.4 11357.0 11393.1 8475.5 8486.6 8554.8 8598.5 8615.0 17972.4 18301.3 18513.7 18534.4 18785.2 19151.8 19309.0 19330.1 19490.9 19686.2 11638.0 11662.3 11679.2 11705.3 11710.3 13555.5 13885.7 14016.4 14019.4 14031.2 10813.7 10851.5 10954.3 11030.2 11300.7 10322.7 10507.4 10644.7 10705.5 10989.5 9329.7 9366.9 9431.9 9461.1 9467.4 6769.2 6864.9 6941.9 7007.6 7043.0 6954.5 7016.3 7055.9 7057.2 7076.8 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#4] prototype.html Cycles:180 Average:5547.70 Median:6227.24 stddev:1490.52 (23.9%) stddev-sans-first:1445.71 01:13:57 INFO - PID 5922 | Values: 498.1 503.0 518.9 521.2 522.2 6278.9 6340.4 6378.1 6379.8 6390.7 6230.3 6260.9 6291.3 6292.6 6303.6 5201.7 5203.6 5211.8 5216.2 5221.3 4846.6 4972.9 5167.3 5178.5 5208.8 4950.5 4951.7 4954.1 4962.2 4973.6 4932.7 4939.6 4957.3 4972.0 4975.5 4428.4 4442.2 4772.0 4852.0 4858.8 6163.9 6167.0 6200.6 6218.8 6224.2 5825.2 5868.9 5929.6 5956.9 5981.0 6592.8 6601.5 6608.0 6621.4 6627.2 5049.9 5262.4 5282.9 5306.4 5316.4 6720.3 6739.4 6801.0 6890.9 6912.9 5337.7 5368.7 5402.6 5404.8 5418.8 5386.4 5464.4 5467.2 5469.0 5483.6 5836.2 5873.3 5887.7 5897.2 5916.9 6489.4 6528.3 6549.8 6573.5 6582.4 1874.4 1902.2 1916.2 1922.8 1924.7 1316.6 1379.7 1408.5 1409.6 1431.9 5557.1 5562.9 5563.3 5564.7 5621.4 6403.6 6587.5 6633.3 6647.7 6656.5 5534.4 5536.4 5540.4 5558.4 5587.2 3453.4 3494.8 3536.6 3540.9 3542.6 6421.4 6426.1 6439.7 6444.5 6451.7 6679.7 6707.4 6742.2 6757.3 6864.0 6373.1 6374.4 6377.0 6395.9 6428.6 6541.6 6572.3 6608.2 6638.9 6640.4 6451.9 6550.6 6601.8 6615.8 6632.1 6360.3 6372.9 6382.7 6412.3 6428.8 5310.7 5323.4 5323.8 5326.8 5333.4 6336.4 6626.5 6631.8 6671.3 6674.3 6064.8 6431.0 6464.1 6465.3 6470.3 6318.7 6409.2 6429.8 6444.9 6503.4 6302.2 6320.7 6336.5 6401.6 6432.3 6562.2 6563.4 6566.9 6615.9 6623.6 6272.7 6329.3 6355.0 6384.3 6388.8 01:13:57 INFO - PID 5922 | 01:13:57 INFO - PID 5922 | [#5] yui.html Cycles:180 Average:25070.43 Median:20468.95 stddev:35970.57 (175.7%) stddev-sans-first:36025.60 01:13:57 INFO - PID 5922 | Values: 876.6 911.7 922.9 928.5 938.9 18742.8 19498.3 19566.5 19573.6 19579.8 17483.8 18056.4 18402.9 18442.0 18463.0 973.9 978.0 979.9 980.1 980.5 912.2 937.1 961.8 971.1 977.1 1030.4 1032.4 1036.5 1036.7 1037.8 1009.5 1033.1 1037.3 1042.5 1044.3 709.7 729.4 746.0 746.2 746.3 19584.8 19599.5 19810.7 19874.0 19908.1 21080.5 22049.0 22202.3 22206.8 22229.2 16017.7 16283.3 16479.5 16502.9 16513.9 3804.6 3814.2 3817.2 3832.5 3838.2 145583.0 145651.0 146264.3 149257.0 149885.0 16986.8 17143.1 17599.6 17601.6 17613.9 30548.5 31379.5 31432.2 31433.4 31449.7 8374.4 8432.9 8467.1 8546.0 8546.7 4172.8 4248.2 4269.5 4277.7 4282.3 5522.7 5638.8 5654.2 5658.4 5670.4 974.1 978.3 981.1 984.9 985.1 687.7 706.2 710.9 714.7 731.2 11801.4 12077.7 12341.9 12400.3 13077.7 695.3 705.8 717.8 718.9 719.0 5526.9 5551.3 5568.5 5577.3 5777.4 115395.4 118657.0 126416.0 127940.0 130404.3 99578.0 105386.0 107466.5 108344.7 112049.0 95002.5 95128.5 98467.0 100672.0 101345.5 12426.7 12805.4 12945.7 12998.7 13013.3 42568.6 43101.8 43322.6 44209.0 45885.3 54931.0 55995.0 56433.4 56586.0 58393.0 18701.1 19100.7 19229.7 19248.6 19287.2 21029.8 21122.5 21144.7 21209.4 21263.9 18874.0 19000.1 19094.0 19171.0 19193.3 17240.3 17380.8 17388.6 17438.7 17778.5 17464.0 17547.0 17613.5 17741.2 17925.2 12452.5 12620.0 12832.9 12849.9 12963.9 13792.0 13893.2 13973.0 14145.9 14288.6 01:13:57 INFO - PID 5922 | -------- Summary: end -------- 01:13:57 INFO - PID 5922 | 01:13:58 INFO - TEST-INFO | 5922: exit 0 01:13:58 INFO - TEST-OK | dromaeo_css | took 1108182ms 01:13:58 INFO - TEST-START | kraken 01:13:58 INFO - Initialising browser for kraken test... 01:13:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59895/getInfo.html -profile /tmp/tmpLw67UU/profile 01:13:58 INFO - TEST-INFO | started process 6284 (/builds/slave/test/build/application/firefox/firefox http://localhost:59895/getInfo.html) 01:14:03 INFO - TEST-INFO | 6284: exit 0 01:14:03 INFO - Browser initialized. 01:14:03 INFO - Running cycle 1/1 for kraken test... 01:14:03 INFO - Using env: {'DISPLAY': ':0', 01:14:03 INFO - 'HOME': '/home/cltbld', 01:14:03 INFO - 'JSGC_DISABLE_POISONING': '1', 01:14:03 INFO - 'LANG': 'en_US.UTF-8', 01:14:03 INFO - 'LANGUAGE': 'en_US:en', 01:14:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:14:03 INFO - 'LOGNAME': 'cltbld', 01:14:03 INFO - 'MAIL': '/var/mail/cltbld', 01:14:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:14:03 INFO - 'MOZ_CRASHREPORTER': '1', 01:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:14:03 INFO - 'MOZ_NO_REMOTE': '1', 01:14:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:03 INFO - 'NO_EM_RESTART': '1', 01:14:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:03 INFO - 'PWD': '/builds/slave/test', 01:14:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:03 INFO - 'RUST_BACKTRACE': 'full', 01:14:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:14:03 INFO - 'SHELL': '/bin/bash', 01:14:03 INFO - 'SHLVL': '1', 01:14:03 INFO - 'TERM': 'linux', 01:14:03 INFO - 'TMOUT': '86400', 01:14:03 INFO - 'USER': 'cltbld', 01:14:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728', 01:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:03 INFO - '_': '/tools/buildbot/bin/python'} 01:14:03 INFO - TEST-INFO | started process 6518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLw67UU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:04 INFO - PID 6518 | 01:14:04 INFO - PID 6518 | (/builds/slave/test/build/application/firefox/firefox:6566): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:14:04 INFO - PID 6518 | 01:14:15 INFO - PID 6518 | RSS: Main: 173056000 01:14:15 INFO - PID 6518 | 01:14:17 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:18 INFO - PID 6518 | RSS: Main: 177999872 01:14:18 INFO - PID 6518 | 01:14:21 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-dft) 01:14:22 INFO - PID 6518 | RSS: Main: 178053120 01:14:22 INFO - PID 6518 | 01:14:25 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-fft) 01:14:25 INFO - PID 6518 | RSS: Main: 174551040 01:14:25 INFO - PID 6518 | 01:14:27 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59895/tests/kraken/driver.html?testName=audio-oscillator) 01:14:28 INFO - PID 6518 | RSS: Main: 174645248 01:14:28 INFO - PID 6518 | 01:14:30 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:31 INFO - PID 6518 | RSS: Main: 174804992 01:14:31 INFO - PID 6518 | 01:14:34 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:35 INFO - PID 6518 | RSS: Main: 177311744 01:14:35 INFO - PID 6518 | 01:14:38 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59895/tests/kraken/driver.html?testName=imaging-desaturate) 01:14:39 INFO - PID 6518 | RSS: Main: 177557504 01:14:39 INFO - PID 6518 | 01:14:42 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59895/tests/kraken/driver.html?testName=json-parse-financial) 01:14:43 INFO - PID 6518 | RSS: Main: 177684480 01:14:43 INFO - PID 6518 | 01:14:44 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:14:45 INFO - PID 6518 | RSS: Main: 177778688 01:14:45 INFO - PID 6518 | 01:14:46 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:14:47 INFO - PID 6518 | RSS: Main: 174772224 01:14:47 INFO - PID 6518 | 01:14:49 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:14:50 INFO - PID 6518 | RSS: Main: 174755840 01:14:50 INFO - PID 6518 | 01:14:53 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:14:53 INFO - PID 6518 | RSS: Main: 175054848 01:14:53 INFO - PID 6518 | 01:14:56 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:14:57 INFO - PID 6518 | RSS: Main: 174788608 01:14:57 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | Cycle 1(1): loaded http://localhost:59895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59895/tests/kraken/driver.html?testName=ai-astar) 01:14:59 INFO - PID 6518 | RSS: Main: 176750592 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | __start_tp_report 01:14:59 INFO - PID 6518 | _x_x_mozilla_page_load 01:14:59 INFO - PID 6518 | _x_x_mozilla_page_load_details 01:14:59 INFO - PID 6518 | |i|pagename|runs| 01:14:59 INFO - PID 6518 | |0;ai-astar;107;107;107;110;109;109;107;109;111;109 01:14:59 INFO - PID 6518 | |1;audio-beat-detection;117;124;117;117;119;117;119;117;150;118 01:14:59 INFO - PID 6518 | |2;audio-dft;162;162;162;162;163;165;165;167;168;164 01:14:59 INFO - PID 6518 | |3;audio-fft;76;74;74;74;74;82;74;76;74;75 01:14:59 INFO - PID 6518 | |4;audio-oscillator;79;80;79;79;79;79;78;79;79;79 01:14:59 INFO - PID 6518 | |5;imaging-gaussian-blur;114;114;114;114;110;115;114;115;115;114 01:14:59 INFO - PID 6518 | |6;imaging-darkroom;147;148;147;148;147;149;150;147;148;147 01:14:59 INFO - PID 6518 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;95 01:14:59 INFO - PID 6518 | |8;json-parse-financial;55;53;53;55;55;55;55;54;52;53 01:14:59 INFO - PID 6518 | |9;json-stringify-tinderbox;37;37;38;41;37;38;37;37;38;38 01:14:59 INFO - PID 6518 | |10;stanford-crypto-aes;78;75;75;75;75;75;75;75;73;74 01:14:59 INFO - PID 6518 | |11;stanford-crypto-ccm;111;114;111;116;114;117;110;118;110;115 01:14:59 INFO - PID 6518 | |12;stanford-crypto-pbkdf2;165;164;169;167;177;166;180;166;171;166 01:14:59 INFO - PID 6518 | |13;stanford-crypto-sha256-iterative;67;64;66;64;72;64;65;70;69;65 01:14:59 INFO - PID 6518 | __end_tp_report 01:14:59 INFO - PID 6518 | __start_cc_report 01:14:59 INFO - PID 6518 | _x_x_mozilla_cycle_collect,954 01:14:59 INFO - PID 6518 | __end_cc_report 01:14:59 INFO - PID 6518 | __startTimestamp1505376899252__endTimestamp 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | ------- Summary: start ------- 01:14:59 INFO - PID 6518 | Number of tests: 14 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.43 (1.3%) stddev-sans-first:1.41 01:14:59 INFO - PID 6518 | Values: 107.0 107.0 107.0 110.0 109.0 109.0 107.0 109.0 111.0 109.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#1] audio-beat-detection Cycles:10 Average:121.50 Median:118.50 stddev:10.24 (8.6%) stddev-sans-first:10.74 01:14:59 INFO - PID 6518 | Values: 117.0 124.0 117.0 117.0 119.0 117.0 119.0 117.0 150.0 118.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.21 (1.3%) stddev-sans-first:2.22 01:14:59 INFO - PID 6518 | Values: 162.0 162.0 162.0 162.0 163.0 165.0 165.0 167.0 168.0 164.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#3] audio-fft Cycles:10 Average:75.30 Median:74.50 stddev:2.50 (3.4%) stddev-sans-first:2.64 01:14:59 INFO - PID 6518 | Values: 76.0 74.0 74.0 74.0 74.0 82.0 74.0 76.0 74.0 75.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 01:14:59 INFO - PID 6518 | Values: 79.0 80.0 79.0 79.0 79.0 79.0 78.0 79.0 79.0 79.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 01:14:59 INFO - PID 6518 | Values: 114.0 114.0 114.0 114.0 110.0 115.0 114.0 115.0 115.0 114.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 01:14:59 INFO - PID 6518 | Values: 147.0 148.0 147.0 148.0 147.0 149.0 150.0 147.0 148.0 147.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:14:59 INFO - PID 6518 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.15 (2.1%) stddev-sans-first:1.17 01:14:59 INFO - PID 6518 | Values: 55.0 53.0 53.0 55.0 55.0 55.0 55.0 54.0 52.0 53.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:1.23 (3.2%) stddev-sans-first:1.27 01:14:59 INFO - PID 6518 | Values: 37.0 37.0 38.0 41.0 37.0 38.0 37.0 37.0 38.0 38.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:1.25 (1.7%) stddev-sans-first:0.71 01:14:59 INFO - PID 6518 | Values: 78.0 75.0 75.0 75.0 75.0 75.0 75.0 75.0 73.0 74.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:114.50 stddev:2.95 (2.6%) stddev-sans-first:2.98 01:14:59 INFO - PID 6518 | Values: 111.0 114.0 111.0 116.0 114.0 117.0 110.0 118.0 110.0 115.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:168.00 stddev:5.38 (3.2%) stddev-sans-first:5.50 01:14:59 INFO - PID 6518 | Values: 165.0 164.0 169.0 167.0 177.0 166.0 180.0 166.0 171.0 166.0 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.84 (4.3%) stddev-sans-first:3.00 01:14:59 INFO - PID 6518 | Values: 67.0 64.0 66.0 64.0 72.0 64.0 65.0 70.0 69.0 65.0 01:14:59 INFO - PID 6518 | -------- Summary: end -------- 01:14:59 INFO - PID 6518 | 01:14:59 INFO - PID 6518 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:14:59 INFO - TEST-INFO | 6518: exit 0 01:14:59 INFO - TEST-OK | kraken | took 61318ms 01:14:59 INFO - SUITE-END | took 1169s 01:15:00 INFO - Completed test suite (00:19:29) 01:15:00 INFO - javascript benchmark 01:15:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8669.691876459154, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.921176970574, 3153.700398462146, 3177.904662860114, 3195.3609278144363, 3211.6467188609263, 6305.716242769075, 6345.7144428500715, 6355.0, 6392.360763923605, 6403.0, 6220.751169953208, 6320.304766475684, 6329.968350158243, 6335.841603959903, 6358.046293056044, 5809.099589563624, 5929.911051334234, 5963.522918166536, 5974.970125149368, 5990.580659353847, 5940.643561386309, 5981.252343457068, 5986.0, 6012.789552365668, 6031.306399764039, 1260.434467594633, 5388.7305634718305, 5787.855303617401, 5790.594658373915, 5966.67183304918, 5844.561657875676, 5862.648241105505, 5924.822255332347, 5927.881442371128, 5935.10973353996, 5833.970830145822, 5837.124431335291, 5897.203877476529, 5908.4091590841, 5913.113033045078, 6213.471854892295, 6287.96856015717, 6371.553991220617, 6443.097966284724, 6445.291017988017, 6823.317668233187, 6827.863442731167, 6913.170419549636, 6916.377526022632, 6945.652717364112, 6769.3907548320885, 6851.520393572452, 6863.725450981955, 6865.210500792423, 6872.450203983669, 6239.875202495925, 6322.9051564226575, 6419.6790160492255, 6421.550491465599, 6443.420092191725, 7069.399101076466, 7143.535670181422, 7149.60677162761, 7160.10498687664, 7173.713051477883, 6719.092922455504, 6721.361470660279, 6749.2238392584495, 6819.283975182633, 6829.829254268584, 6702.731890724414, 6760.290169532227, 6808.455323574201, 6850.554713943578, 6939.271376505495, 6747.325267473311, 6794.014867844135, 6818.352256535622, 6828.965855170792, 6840.179178498513, 6841.863162736817, 6919.688614012382, 6924.757633482804, 6929.826754331182, 6947.235804061549, 5151.407588127413, 5223.712695801767, 5228.163493840967, 5236.476352364809, 5280.841574752763, 4612.515685852937, 4636.211843986531, 4649.907271791127, 4654.976725116353, 4655.813767449332, 5875.941240587625, 5883.14694369314, 5885.205497257815, 5971.910421343683, 5978.1929439525975, 6925.411340036053, 6951.548149370275, 6999.8600027999155, 7012.964935175291, 7017.912223605349, 5926.140709597084, 5930.762769489258, 5981.252343457068, 6013.368596297326, 6017.669028203491, 5751.568632352591, 5830.038043722739, 5860.912086318709, 5893.057110862242, 5965.701714914237, 6623.458039420826, 6634.668266586651, 6660.200775906922, 6667.533272670964, 6669.833254168685, 6871.484638652221, 6943.375096241362, 6947.0, 6961.477889158232, 6961.7215311389, 6596.241432235354, 6625.370589793962, 6695.732170713117, 6698.698558564779, 6731.0, 6670.599764014175, 6726.058351830649, 6735.393814556714, 6783.05037294789, 6794.83012924661, 6893.655317234218, 6974.442044636518, 6987.091678081817, 6994.6852391643515, 7007.089078419773, 6645.634490103091, 6646.501512386687, 6659.900101498384, 6701.832454188684, 6759.5606285591275, 6592.736290548516, 6608.570442921195, 6646.435053020354, 6649.46804255668, 6662.533622646368, 6559.278479367361, 6624.205095388585, 6625.734970601315, 6635.734570617315, 6670.699818508276, 6669.899951500634, 6681.665916704048, 6703.430208432338, 6741.662916854039, 6743.325667433218, 6316.968415157895, 6423.29343772194, 6481.222253329631, 6490.091387205701, 6584.736610535525], "value": 6205.415431380822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.0931452116369, 845.0873057098335, 861.7888617288766, 862.1593945902745, 876.3733930239879, 40307.79846100769, 40962.59037409625, 41193.0, 41245.793771031174, 41293.58706412939, 36815.26369472609, 37019.259614807685, 40438.19123617526, 40520.797396013055, 40690.0, 7683.078030636331, 7795.454318197729, 7813.218678132198, 7834.764957051298, 7850.528968261894, 7651.234876512332, 7734.961325193366, 7743.148253692089, 7748.7675369739, 7767.495112817677, 7745.612719364038, 7768.57272849993, 7813.9609301953415, 7821.139674635786, 7832.647530861096, 7755.108162561293, 7769.494982826126, 7772.7279545216215, 7788.415868809862, 7790.766277011699, 7603.5057721248495, 7663.042119735033, 7663.885041724378, 7667.118281397599, 7667.961660191719, 36210.0, 36289.45565816515, 36400.63599363999, 36408.0, 36461.45307820385, 3484.390231709466, 3527.1358517163203, 3528.100334414708, 3528.558930133733, 3530.6645868642436, 30957.071287861174, 31071.68928310733, 31098.0, 31117.377652446823, 31182.376352472824, 5053.267276244961, 5203.765830537635, 5224.529792318672, 5250.396204436501, 5260.526552610245, 185262.0, 188709.0, 191396.0, 191652.0, 199493.00253498784, 48142.75928620405, 48470.515294847304, 48742.5125748738, 48805.0, 48977.75511122493, 50440.243396349084, 50876.0, 50937.0, 50940.0, 51153.74423127861, 15779.921100394655, 15820.288087036111, 15926.124063176636, 15935.920320398556, 16120.355185792672, 13316.667083322995, 13355.666108347368, 13364.866351336363, 13372.598822035354, 13373.66565835862, 12561.371931403393, 12715.046371522172, 12828.486860525662, 12915.612531624067, 12964.0, 5070.442251352349, 5119.462456442095, 5142.228665700175, 5171.2501687255135, 5315.787368505294, 974.6978436684509, 989.8762654668167, 992.6029588164647, 1009.9192064634958, 1012.2610494339174, 22360.32919012432, 22453.663195052086, 22472.0, 22568.322950311518, 22681.88659056694, 1108.2906939558688, 1112.5660992213043, 1118.3904771899333, 1120.0927248928394, 1126.0822429719751, 11744.706382340339, 11922.701932451759, 11970.940145299392, 11972.700682483008, 11983.820242696367, 224887.0, 226482.0, 226574.0, 226596.0, 226648.0, 50015.0, 50103.0, 50188.749056254484, 50190.0, 50319.0, 1409.8942579306388, 1441.4162264282982, 1453.3314675249292, 1454.2074569359513, 1457.3733294683177, 22081.447963801034, 22448.32655020352, 22526.66210006884, 22800.201992930168, 22848.885755571115, 36653.08367290733, 36955.0, 36976.44535332026, 37000.0, 37015.8149209263, 186969.0, 188314.0, 188621.0, 188932.0, 189181.0, 33828.66171338255, 33840.49239261364, 34979.65020349764, 35314.82342588373, 35642.821785890905, 44446.11107777762, 45437.54562454333, 45460.090798184516, 45669.0, 45735.54264457313, 32716.509252360756, 32776.0, 32878.34243315073, 33039.174020648716, 33141.83429082839, 32273.677263228008, 33206.16984575405, 33215.66784332126, 33444.498332525516, 33797.0, 36099.0, 37475.06312342213, 37561.4365784508, 37564.436533452565, 37618.0, 32288.83855580801, 32359.676403235666, 32391.676083238865, 32875.835620821745, 32960.340793184485, 23019.65470517977, 23234.3029709109, 23238.1866634667, 23240.18659346915, 23856.16503422372], "value": 16996.066312761366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.468797610306, 556.4935908323426, 567.4779203133118, 577.1515871668647, 586.1910563422477, 21680.674789878143, 22566.43583910403, 22649.773502264972, 22682.65976010359, 22711.659325110137, 23621.0, 24442.3889402765, 24795.50408991819, 24910.25269241921, 25142.497150056988, 6455.838604034901, 6538.6076835389795, 6566.409023187912, 6570.047343135243, 6571.44142747867, 6150.815475535741, 6447.516436267299, 6495.155629768124, 6551.082848401227, 6553.246376666697, 6335.208098987627, 6335.493160547145, 6338.461230795388, 6340.968295158517, 6366.331535188808, 6259.906101408483, 6310.242770867525, 6334.049892516114, 6340.0, 6341.651209183493, 5676.0, 5852.824415267549, 5864.472197502245, 5872.647641141502, 5876.3242227144, 28330.85834570814, 28373.432531349463, 28866.85566572175, 28917.0, 29026.12921612355, 2014.5567975045467, 2041.9183232670823, 2045.222815330165, 2059.4130672758192, 2066.173530587762, 18556.536086597807, 18847.151878165514, 18886.811131888644, 18974.05129743521, 19151.616967660568, 2377.476955069882, 2436.5248776488593, 2443.438009257863, 2451.509698060377, 2488.7884529814987, 123869.0, 130109.34945325307, 131242.0, 141290.0, 145647.99999999895, 20100.195992160443, 20270.69593956092, 21234.362969110953, 21751.78248217529, 21827.345179644635, 41672.0, 42023.57976420258, 42067.36898946518, 42146.0, 42240.366394504104, 11572.94213528927, 11641.6507504775, 11655.358955257543, 11661.35862527569, 11711.355875426763, 9731.172850307661, 9883.802323953481, 9919.80160396788, 9952.452615106238, 10015.949920250352, 10604.681859544226, 10778.514966826511, 11022.669319920415, 11033.724156896142, 11345.432728363714, 3718.8512459501317, 3729.254149170177, 4208.600182982612, 4318.0, 4438.312061630452, 927.4620719982394, 944.15026476172, 954.7994921066515, 960.4093482508207, 963.3689933093834, 18837.0, 19097.713534296996, 19310.420687379403, 19323.51691207731, 19545.315913942944, 997.7605374710017, 1019.2457581389718, 1029.7734498410339, 1032.3289861590026, 1033.6950599573145, 10479.476026198812, 10553.947230263799, 10595.523201455953, 10699.037086662081, 10753.193510486744, 462819.0, 479883.0, 486771.0, 500060.0, 504983.0, 111193.0, 112038.43980780045, 114522.13694657534, 115123.42438287755, 116818.0, 1025.4206373399006, 1059.2638116509106, 1146.8623765148068, 1180.8701042885275, 1203.5246077799395, 19468.123934423267, 19625.214991400186, 19858.70211946793, 19896.104675289935, 20408.89795551013, 55382.44617553934, 56311.71844140753, 56513.15230271467, 57712.0, 58306.0, 68053.31946680667, 68405.65797170982, 69907.65046174737, 71327.0, 72436.63781681057, 19629.50926226856, 19896.90051549733, 19914.203431862563, 20003.199872005538, 20041.799582003994, 22298.442538936655, 22408.887955560116, 22459.764712940945, 22508.324750257518, 22524.662130067733, 17662.116894155497, 17983.820161798216, 18007.81992180114, 18017.189226484577, 18023.72964405509, 15291.388344466097, 16075.19624018771, 16127.75808362852, 16162.515124546282, 16620.501384958472, 18009.909950450165, 18281.268749250412, 18397.080145992913, 18460.07699615041, 18609.348672796386, 19330.710039349702, 19488.317908873123, 19492.31776887802, 19533.609327813647, 19759.110840012523, 17774.644507109526, 17817.643647127243, 17836.197371118073, 18108.09459526992, 18123.45629631113], "value": 12603.16049248533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.186756078792, 1367.432515506065, 1383.2806940390997, 1385.3419625677805, 1389.5622878793174, 14808.259587020646, 15378.384864605416, 15467.845321546782, 15478.845211547881, 15491.147986860718, 14880.553583392488, 14943.551693449186, 14994.625134371647, 14998.100113993169, 14998.175100369475, 2614.7254538273446, 2752.0230318237036, 2756.324700448383, 2760.4755096531694, 2765.25338158697, 2786.8049236553447, 2789.0, 2815.7184281571886, 2816.8591570421395, 2828.688844227144, 2672.0, 2742.931426714328, 2854.029629925825, 2858.899938502153, 2861.370498490329, 2791.734785195403, 2795.580662900561, 2843.644544431946, 2854.9999999999895, 2857.6142220800134, 2767.1975127213086, 2796.300924768808, 2801.047643801097, 2803.6074949507083, 2835.277004363895, 14579.92710036443, 14616.123032618078, 14843.480478183212, 14883.107013579112, 14931.25343732809, 7990.520568765893, 8265.0, 8287.337013038943, 8293.170682931719, 8301.29438997686, 5333.919991200135, 5439.972800136014, 5497.835064948058, 5522.641028333145, 5605.887882242332, 1880.069365664005, 1892.7728672559244, 1894.6684330242153, 1936.4868309897888, 1956.4032969944162, 26453.867730661415, 27129.593056104175, 27133.728662713318, 27139.0, 27157.86421067882, 6969.721211151497, 7035.366816986496, 7222.819429514199, 7312.268773122645, 7426.331630153312, 20350.0, 20369.490762730755, 20413.081411336527, 20448.59102817965, 20488.282910098074, 8087.959560202161, 8356.498610083414, 8377.748667539983, 8381.16188381157, 8389.328853691812, 7299.19708832028, 7447.329740323397, 7484.663190156456, 7485.326320631169, 7497.437692173109, 5510.283663123768, 5692.089265717465, 5777.537796976232, 5799.0, 5840.123981402823, 1687.2576066530687, 1709.7777288952357, 1753.395078697847, 1815.5370380552874, 1856.1925562380409, 868.6134670071757, 877.4033657113224, 904.2359206470653, 916.8074704312036, 917.064594114, 8424.157584241526, 8438.789030274169, 8440.240378365976, 8497.66009359631, 8564.61459234336, 714.6962540920089, 725.6516871901517, 725.7423614616735, 732.1580182789834, 801.1227705662291, 4859.708417494961, 5060.342155519759, 5102.5662818660085, 5157.277981082651, 5206.921896171561, 21288.574228515343, 21406.0, 21623.56752864934, 22162.445938851335, 22197.11211551552, 21213.681794773092, 21697.240596579042, 21833.67249491259, 21855.562888742137, 21917.671234931488, 10654.254202205771, 11300.491477883515, 11330.376829274304, 11357.0, 11393.145514086476, 8475.533845638549, 8486.575671216538, 8554.78613034679, 8598.484090954562, 8614.956925215334, 17972.370967016093, 18301.26794928188, 18513.72229416587, 18534.351297705056, 18785.248590056246, 19151.808481915003, 19309.0, 19330.13014414383, 19490.90254548718, 19686.212551497778, 11638.0, 11662.300261984308, 11679.182457228253, 11705.297682139098, 11710.297382157098, 13555.525556605471, 13885.72228555403, 14016.369263383376, 14019.369128389042, 14031.228282444155, 10813.729656758644, 10851.511681974172, 10954.287971281841, 11030.22788404804, 11300.717482063013, 10322.741931451774, 10507.369557826554, 10644.733881653021, 10705.464726763475, 10989.450527473755, 9329.673461428818, 9366.859497107685, 9431.868175818945, 9461.148496635336, 9467.431954082776, 6769.153855768029, 6864.862702746017, 6941.947341084318, 7007.649617519001, 7043.0, 6954.478414119062, 7016.26329235423, 7055.929440705528, 7057.153141623038, 7076.752313668997], "value": 6739.840617371034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.0674201281864, 502.97188199429837, 518.8754698872272, 521.2467983763462, 522.2479629333759, 6278.874422511547, 6340.429361357477, 6378.075179099033, 6379.840503987402, 6390.744370225197, 6230.283517395501, 6260.937390626093, 6291.307956124822, 6292.5595208335435, 6303.590266632666, 5201.68789872607, 5203.609729270301, 5211.765470553815, 5216.157194329081, 5221.269022336875, 4846.636502262327, 4972.900541989158, 5167.276581278624, 5178.482151784829, 5208.765605547759, 4950.480199579047, 4951.727654978975, 4954.083494553501, 4962.156433406311, 4973.5772459341, 4932.654714169991, 4939.580135688435, 4957.256411538262, 4972.0055988802205, 4975.477574854624, 4428.402165707653, 4442.244818380883, 4771.976140119312, 4851.975740121312, 4858.805647774085, 6163.87672246557, 6167.044108163242, 6200.565960382775, 6218.782342617987, 6224.190855188842, 5825.155352473867, 5868.853278668067, 5929.644221346733, 5956.880862382772, 5980.953333166678, 6592.80221593353, 6601.504887133484, 6607.9669601651685, 6621.437177839889, 6627.1716035495565, 5049.873753156164, 5262.368515778093, 5282.894342113136, 5306.416294207634, 5316.441773613792, 6720.252734289071, 6739.359760822714, 6801.0, 6890.8621827563165, 6912.930870691279, 5337.653052551572, 5368.677879327252, 5402.567794576425, 5404.83785486436, 5418.810341638103, 5386.380566234855, 5464.371597266365, 5467.234587157801, 5469.0, 5483.588730845203, 5836.182934389189, 5873.295204575393, 5887.676177810176, 5897.174395584621, 5916.911246331309, 6489.415952564292, 6528.278881037763, 6549.836254093686, 6573.506986975996, 6582.3746744059235, 1874.3533480949052, 1902.1929167291128, 1916.2047750183517, 1922.7692676878864, 1924.6824273994914, 1316.6379245707508, 1379.661982814217, 1408.478862820763, 1409.59121854661, 1431.8568143185598, 5557.138643510262, 5562.9443705563235, 5563.304586926634, 5564.693941833157, 5621.381648018714, 6403.615783053032, 6587.473002159816, 6633.303503132198, 6647.66761661915, 6656.500762442836, 5534.446555344514, 5536.363318218457, 5540.36285827135, 5558.416366281483, 5587.217789509472, 3453.4129198036394, 3494.8427320770625, 3536.5579302587175, 3540.858365665396, 3542.628024057437, 6421.357864213542, 6426.132472116298, 6439.7424103035355, 6444.548881578338, 6451.677416129269, 6679.666016699146, 6707.396334329934, 6742.190937087483, 6757.3242675732035, 6864.048459162508, 6373.139626150503, 6374.394432528902, 6376.968115159488, 6395.904061439175, 6428.582142160838, 6541.6402097885075, 6572.272506909579, 6608.240052394036, 6638.867222655616, 6640.435562977201, 6451.903221451588, 6550.6069635822005, 6601.801945941629, 6615.801525954229, 6632.081883971037, 6360.300366959538, 6372.87254254903, 6382.723455309049, 6412.332793473824, 6428.8071357859335, 5310.654807437504, 5323.441038690882, 5323.760430780547, 5326.813561525328, 5333.359996800409, 6336.429721324918, 6626.469882409492, 6631.834204144935, 6671.299513551201, 6674.332566743286, 6064.818055458343, 6430.971044633024, 6464.127342808849, 6465.288818229897, 6470.320616335405, 6318.684065796784, 6409.166808314889, 6429.7749578764515, 6444.903326450013, 6503.374580987506, 6302.243730752339, 6320.747170113144, 6336.461400780985, 6401.615903045832, 6432.324605916311, 6562.2125344957, 6563.3764792344655, 6566.9014964776525, 6615.900761488485, 6623.635700036544, 6272.717727702173, 6329.272133704683, 6355.0, 6384.297727250092, 6388.808335749749], "value": 5118.862506494999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.6230520876021, 911.740154056094, 922.9400088994215, 928.5078908178667, 938.9295802814788, 18742.812571874278, 19498.317558885443, 19566.510837229078, 19573.60852782947, 19579.804201957977, 17483.82516174838, 18056.368027119053, 18402.907985460086, 18442.0, 18463.0, 973.8977407372213, 978.021978021978, 979.9265055120894, 980.083621813603, 980.4950450517989, 912.2337236721153, 937.0957026469456, 961.7835986902961, 971.1017308989192, 977.081543349253, 1030.4487099401822, 1032.4321623107298, 1036.471399586209, 1036.7045392063264, 1037.8235699930992, 1009.535613617733, 1033.0960409641564, 1037.258360272405, 1042.4579218806255, 1044.305536818015, 709.7019251914209, 729.4164668265366, 745.9664315105833, 746.1568427676744, 746.3394895517451, 19584.80415195844, 19599.510012249666, 19810.70283945742, 19874.0, 19908.104135313944, 21080.472988175265, 22049.00779464928, 22202.333929982127, 22206.777932220633, 22229.221977230718, 16017.679646407123, 16283.348666053344, 16479.505614831454, 16502.92730972495, 16513.91743041289, 3804.5814960354337, 3814.218085292536, 3817.2174704185854, 3832.5209348831395, 3838.193979264358, 145583.0, 145651.0, 146264.26867865698, 149257.0, 149885.0, 16986.83013169877, 17143.142842857807, 17599.64800703979, 17601.647967040586, 17613.91193044052, 30548.54177187344, 31379.529307060413, 31432.21419464486, 31433.37133257322, 31449.685503144676, 8374.413791034569, 8432.873506897402, 8467.110953349933, 8546.017208021032, 8546.743597692079, 4172.77049762266, 4248.171606536695, 4269.487661480643, 4277.743335399886, 4282.314829627245, 5522.696251706115, 5638.802641907513, 5654.236678048493, 5658.405867383948, 5670.376258611549, 974.1427543761586, 978.3493976505545, 981.0581841432162, 984.8522721591676, 985.0691096913348, 687.6767919078026, 706.1949377709416, 710.9431245500348, 714.7212587091038, 731.1518638379455, 11801.40992950349, 12077.698057548632, 12341.876581234252, 12400.31798251105, 13077.673058173432, 695.3290075077574, 705.7812078255757, 717.8348979734691, 718.9460790440738, 718.9820254493679, 5526.861828454241, 5551.333839939233, 5568.470995255444, 5577.27495425592, 5777.422257774189, 115395.42302288603, 118657.031883309, 126416.0, 127940.0, 130404.3479782595, 99578.0, 105386.0, 107466.46266768617, 108344.70043319817, 112049.0, 95002.524987376, 95128.52435737777, 98467.0, 100672.0, 101345.49327253316, 12426.689332766753, 12805.359732013176, 12945.741085178432, 12998.675033124247, 13013.349332533146, 42568.5743142577, 43101.7844910786, 43322.566774333114, 44209.0, 45885.31172032489, 54931.0, 55995.0, 56433.43566564282, 56586.0, 58393.0, 18701.06494675288, 19100.71348929795, 19229.711554326415, 19248.61502769965, 19287.228510859968, 21029.789702102782, 21122.471938201666, 21144.682829757872, 21209.36371908845, 21263.8936805315, 18874.0, 19000.144993475602, 19094.0, 19171.0, 19193.32823351176, 17240.310387584355, 17380.826191738426, 17388.565285867953, 17438.651226975642, 17778.46664600064, 17464.0, 17547.0, 17613.471595852145, 17741.201645926223, 17925.19336629881, 12452.501899924264, 12620.0, 12832.871671283168, 12849.87150128524, 12963.935180324039, 13792.0, 13893.166410015432, 13973.0, 14145.858541414866, 14288.57134285973], "value": 9259.22262466542, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1420.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 110.0, 109.0, 109.0, 107.0, 109.0, 111.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 117.0, 117.0, 119.0, 117.0, 119.0, 117.0, 150.0, 118.0], "value": 121.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 165.0, 165.0, 167.0, 168.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 74.0, 74.0, 82.0, 74.0, 76.0, 74.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 110.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 149.0, 150.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 55.0, 55.0, 55.0, 54.0, 52.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 41.0, 37.0, 38.0, 37.0, 37.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 73.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 111.0, 116.0, 114.0, 117.0, 110.0, 118.0, 110.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 169.0, 167.0, 177.0, 166.0, 180.0, 166.0, 171.0, 166.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 64.0, 72.0, 64.0, 65.0, 70.0, 69.0, 65.0], "value": 66.6, "unit": "score"}]}]} 01:15:00 INFO - Return code: 0 01:15:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:15:00 INFO - # TBPL SUCCESS # 01:15:00 INFO - Running post-action listener: _package_coverage_data 01:15:00 INFO - Running post-action listener: _resource_record_post_action 01:15:00 INFO - [mozharness: 2017-09-14 08:15:00.520138Z] Finished run-tests step (success) 01:15:00 INFO - Running post-run listener: _resource_record_post_run 01:15:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 434176; Write bytes: 400777216; Read time: 128; Write time: 262684 01:15:00 INFO - TinderboxPrint: CPU usage
13.1% 01:15:00 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 128 01:15:00 INFO - TinderboxPrint: I/O write bytes / time
400,777,216 / 262,684 01:15:00 INFO - TinderboxPrint: CPU idle
8,227.8 (86.9%) 01:15:00 INFO - TinderboxPrint: CPU user
1,192.4 (12.6%) 01:15:00 INFO - TinderboxPrint: Swap in / out
0 / 0 01:15:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74543104; Read time: 0; Write time: 46620 01:15:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:15:00 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 430080; Write bytes: 326234112; Read time: 116; Write time: 216064 01:15:01 INFO - Running post-run listener: _upload_blobber_files 01:15:01 INFO - Blob upload gear active. 01:15:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:15:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:15:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:15:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:15:01 INFO - (blobuploader) - INFO - Open directory for files ... 01:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:02 INFO - (blobuploader) - INFO - Done attempting. 01:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:09 INFO - (blobuploader) - INFO - Done attempting. 01:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:10 INFO - (blobuploader) - INFO - Done attempting. 01:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:11 INFO - (blobuploader) - INFO - Done attempting. 01:15:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:15:11 INFO - Return code: 0 01:15:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:15:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:15:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66346915e0934684fdb6c54f986da7c18818474b11acb395b26bc30672762b24f920e08a37ad95b0e4d280d1403230a94deafdc14c362310780d53c246834df9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11dfd4d91cb2ea37d42e6865b3007f68fff71c06f5f84af61c6f23dd30620e3f4cc5c4809ef624fffdbe93c689f52441d3ca03664a45b5f9c53c42d9388f6038", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7504044b420364a7abf13b16b98c4d6338cfbdea26b8abc94409077e8b00defc56f10deb186a6b6c282cee719f4b4a4ab7ace78c988809a4a99433c872ba6c79", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c705c30addf27957b9e98691f71882c6cd967be2f5ecaf3bc2c531a540ae07029a43e90538c8dbc901e9c098197638fed06984e6cd5474b4ddaac60382dce876"} 01:15:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:15:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:15:11 INFO - Contents: 01:15:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66346915e0934684fdb6c54f986da7c18818474b11acb395b26bc30672762b24f920e08a37ad95b0e4d280d1403230a94deafdc14c362310780d53c246834df9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11dfd4d91cb2ea37d42e6865b3007f68fff71c06f5f84af61c6f23dd30620e3f4cc5c4809ef624fffdbe93c689f52441d3ca03664a45b5f9c53c42d9388f6038", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7504044b420364a7abf13b16b98c4d6338cfbdea26b8abc94409077e8b00defc56f10deb186a6b6c282cee719f4b4a4ab7ace78c988809a4a99433c872ba6c79", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c705c30addf27957b9e98691f71882c6cd967be2f5ecaf3bc2c531a540ae07029a43e90538c8dbc901e9c098197638fed06984e6cd5474b4ddaac60382dce876"} 01:15:11 INFO - Running post-run listener: copy_logs_to_upload_dir 01:15:11 INFO - Copying logs to upload dir... 01:15:11 INFO - mkdir: /builds/slave/test/build/upload/logs 01:15:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.873266 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-14 01:15:12.051315) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:12.057614) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 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-Non-PGO/sha512/66346915e0934684fdb6c54f986da7c18818474b11acb395b26bc30672762b24f920e08a37ad95b0e4d280d1403230a94deafdc14c362310780d53c246834df9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11dfd4d91cb2ea37d42e6865b3007f68fff71c06f5f84af61c6f23dd30620e3f4cc5c4809ef624fffdbe93c689f52441d3ca03664a45b5f9c53c42d9388f6038", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7504044b420364a7abf13b16b98c4d6338cfbdea26b8abc94409077e8b00defc56f10deb186a6b6c282cee719f4b4a4ab7ace78c988809a4a99433c872ba6c79", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c705c30addf27957b9e98691f71882c6cd967be2f5ecaf3bc2c531a540ae07029a43e90538c8dbc901e9c098197638fed06984e6cd5474b4ddaac60382dce876"} build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66346915e0934684fdb6c54f986da7c18818474b11acb395b26bc30672762b24f920e08a37ad95b0e4d280d1403230a94deafdc14c362310780d53c246834df9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11dfd4d91cb2ea37d42e6865b3007f68fff71c06f5f84af61c6f23dd30620e3f4cc5c4809ef624fffdbe93c689f52441d3ca03664a45b5f9c53c42d9388f6038", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7504044b420364a7abf13b16b98c4d6338cfbdea26b8abc94409077e8b00defc56f10deb186a6b6c282cee719f4b4a4ab7ace78c988809a4a99433c872ba6c79", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c705c30addf27957b9e98691f71882c6cd967be2f5ecaf3bc2c531a540ae07029a43e90538c8dbc901e9c098197638fed06984e6cd5474b4ddaac60382dce876"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:12.086125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:12.086480) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505371476.473801-2119892728 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:12.170509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:12.170889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:12.174347) ========= ========= Total master_lag: 0.30 =========