builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1506293010.8 results: success (0) revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.801818) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.802437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.802718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.912755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:30.913353) ========= 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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 15:43: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% 103M=0s 2017-09-24 15:43:31 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120110 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.075162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.075450) ========= 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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020144 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.145328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-24 15:43:31.145629) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b44e80e0590e6eed86a1902365424673c8c2eaec --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 b44e80e0590e6eed86a1902365424673c8c2eaec --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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 15:43:31,239 truncating revision to first 12 chars 2017-09-24 15:43:31,239 Setting DEBUG logging. 2017-09-24 15:43:31,239 attempt 1/10 2017-09-24 15:43:31,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b44e80e0590e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 15:43:32,056 unpacking tar archive at: mozilla-central-b44e80e0590e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.123173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-24 15:43:32.287146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.287442) ========= script_repo_revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.287852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.288128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.302122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-24 15:43:32.302534) ========= /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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:32 INFO - MultiFileLogger online at 20170924 15:43:32 in /builds/slave/test 15:43: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 15:43:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:32 INFO - {'append_to_log': False, 15:43:32 INFO - 'base_work_dir': '/builds/slave/test', 15:43:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:32 INFO - 'branch': 'Firefox-Non-PGO', 15:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:32 INFO - 'code_coverage': False, 15:43:32 INFO - 'config_files': ('talos/linux_config.py',), 15:43:32 INFO - 'default_actions': ('clobber', 15:43:32 INFO - 'read-buildbot-config', 15:43:32 INFO - 'download-and-extract', 15:43:32 INFO - 'populate-webroot', 15:43:32 INFO - 'create-virtualenv', 15:43:32 INFO - 'install', 15:43:32 INFO - 'setup-mitmproxy', 15:43:32 INFO - 'run-tests'), 15:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:32 INFO - 'disable_ccov_upload': False, 15:43:32 INFO - 'disable_stylo': False, 15:43:32 INFO - 'download_minidump_stackwalk': True, 15:43:32 INFO - 'download_symbols': 'ondemand', 15:43:32 INFO - 'enable_stylo': False, 15:43:32 INFO - 'enable_webrender': False, 15:43:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:32 INFO - 'gecko_profile': False, 15:43:32 INFO - 'gecko_profile_interval': 0, 15:43:32 INFO - 'installer_path': 'installer.exe', 15:43:32 INFO - 'log_level': 'info', 15:43:32 INFO - 'log_name': 'talos', 15:43:32 INFO - 'log_to_console': True, 15:43:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:32 INFO - 'opt_config_files': (), 15:43:32 INFO - 'pip_index': False, 15:43:32 INFO - 'suite': 'dromaeojs-e10s', 15:43:32 INFO - 'system_bits': '32', 15:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:32 INFO - 'title': 'talos-linux64-ix-084', 15:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:32 INFO - 'use_talos_json': True, 15:43:32 INFO - 'verify': 'False', 15:43:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:32 INFO - 'work_dir': 'build'} 15:43:32 INFO - [mozharness: 2017-09-24 22:43:32.542040Z] Running clobber step. 15:43:32 INFO - Running pre-action listener: _resource_record_pre_action 15:43:32 INFO - Running main action method: clobber 15:43:32 INFO - rmtree: /builds/slave/test/build 15:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:33 INFO - Running post-action listener: _resource_record_post_action 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.534176Z] Finished clobber step (success) 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.534273Z] Running read-buildbot-config step. 15:43:33 INFO - Running pre-action listener: _resource_record_pre_action 15:43:33 INFO - Running main action method: read_buildbot_config 15:43:33 INFO - Using buildbot properties: 15:43:33 INFO - { 15:43:33 INFO - "project": "", 15:43:33 INFO - "product": "firefox", 15:43:33 INFO - "who": "archaeopteryx@coole-files.de", 15:43:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:43:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:43:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:43:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:43:33 INFO - "stage_platform": "linux64", 15:43:33 INFO - "basedir": "/builds/slave/test", 15:43:33 INFO - "buildnumber": 1175, 15:43:33 INFO - "platform": "ubuntu64_hw", 15:43:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:43:33 INFO - "slavebuilddir": "test", 15:43:33 INFO - "taskId": "ZD6TYDrCTsKLCzo1G1f-eQ", 15:43:33 INFO - "branch": "mozilla-central", 15:43:33 INFO - "script_repo_revision": "production", 15:43:33 INFO - "revision": "b44e80e0590e6eed86a1902365424673c8c2eaec", 15:43:33 INFO - "slavename": "talos-linux64-ix-084", 15:43:33 INFO - "repo_path": "mozilla-central" 15:43:33 INFO - } 15:43:33 INFO - Finding installer, test and symbols from parent task. 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZD6TYDrCTsKLCzo1G1f-eQ'}, attempt #1 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZD6TYDrCTsKLCzo1G1f-eQ'}, attempt #1 15:43:34 INFO - Task dependencies: B7iTL-CwQoyRUaZIwcocAA 15:43:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA'}, attempt #1 15:43:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip 15:43:34 INFO - Running post-action listener: _resource_record_post_action 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.866473Z] Finished read-buildbot-config step (success) 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.866692Z] Running download-and-extract step. 15:43:34 INFO - Running pre-action listener: _resource_record_pre_action 15:43:34 INFO - Running main action method: download_and_extract 15:43:34 INFO - mkdir: /builds/slave/test/build/tests 15:43: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')]} 15:43:34 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:43:35 INFO - Downloaded 989 bytes. 15:43:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:43:35 INFO - Using the following test package requirements: 15:43:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:43:35 INFO - u'common': [u'target.common.tests.zip'], 15:43:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:43:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:43:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:43:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:43:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:43:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:43:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:43:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:43:35 INFO - u'target.web-platform.tests.tar.gz'], 15:43:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:43:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip 15:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip into memory 15:43:38 INFO - Content-Length response header: 54943940 15:43:38 INFO - Bytes received: 54943940 15:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip 15:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip into memory 15:43:50 INFO - Content-Length response header: 14513823 15:43:50 INFO - Bytes received: 14513823 15:43: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')]} 15:43:50 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:43:55 INFO - Downloaded 61537979 bytes. 15:43:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - mkdir: /builds/slave/test/properties 15:43:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:55 INFO - Contents: 15:43:55 INFO - build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - Running post-action listener: find_tests_for_verification 15:43:55 INFO - Running post-action listener: set_extra_try_arguments 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.187946Z] Finished download-and-extract step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.188045Z] Running populate-webroot step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: populate_webroot 15:43:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tresize', 15:43:55 INFO - 'tcanvasmark']}, 15:43:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_css', 15:43:55 INFO - 'kraken']}, 15:43:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:43:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['basic_compositor_video', 15:43:55 INFO - 'glvideo']}, 15:43:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:43:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['ts_paint_webext', 15:43:55 INFO - 'tp5o_webext']}, 15:43:55 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:43:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest']}, 15:43:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o']}, 15:43:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--stylo-threads=1', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}, 15:43:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}}} 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.203561Z] Finished populate-webroot step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.203651Z] Running create-virtualenv step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: create_virtualenv 15:43:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:43:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:43:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:43:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:56 INFO - Installing pip...............done. 15:43:56 INFO - Return code: 0 15:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:56 INFO - Reading from file tmpfile_stdout 15:43:56 INFO - Output received: 15:43:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:43:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43: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')]} 15:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:43: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', 'pip>=1.5'] in /builds/slave/test/build 15:43: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 pip>=1.5 15:43:56 INFO - Using env: {'DISPLAY': ':0', 15:43:56 INFO - 'HOME': '/home/cltbld', 15:43:56 INFO - 'LANG': 'en_US.UTF-8', 15:43:56 INFO - 'LANGUAGE': 'en_US:en', 15:43:56 INFO - 'LOGNAME': 'cltbld', 15:43:56 INFO - 'MAIL': '/var/mail/cltbld', 15:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:56 INFO - 'MOZ_NO_REMOTE': '1', 15:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:56 INFO - 'NO_EM_RESTART': '1', 15:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:56 INFO - 'PWD': '/builds/slave/test', 15:43:56 INFO - 'SHELL': '/bin/bash', 15:43:56 INFO - 'SHLVL': '1', 15:43:56 INFO - 'TERM': 'linux', 15:43:56 INFO - 'TMOUT': '86400', 15:43:56 INFO - 'USER': 'cltbld', 15:43:56 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:56 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking pip>=1.5 15:43:57 INFO - Running setup.py egg_info for package pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing collected packages: pip 15:43:57 INFO - Found existing installation: pip 1.1 15:43:57 INFO - Uninstalling pip: 15:43:57 INFO - Successfully uninstalled pip 15:43:57 INFO - Running setup.py install for pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Successfully installed pip 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:57 INFO - Using env: {'DISPLAY': ':0', 15:43:57 INFO - 'HOME': '/home/cltbld', 15:43:57 INFO - 'LANG': 'en_US.UTF-8', 15:43:57 INFO - 'LANGUAGE': 'en_US:en', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MAIL': '/var/mail/cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SHLVL': '1', 15:43:57 INFO - 'TERM': 'linux', 15:43:57 INFO - 'TMOUT': '86400', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking psutil>=3.1.1 15:43: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 15:43: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 15:43: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 15:43: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 15:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:59 INFO - Installing collected packages: psutil 15:43:59 INFO - Running setup.py install for psutil 15:43:59 INFO - building 'psutil._psutil_linux' extension 15:43:59 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 15:43:59 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 15:43:59 INFO - building 'psutil._psutil_posix' extension 15:43:59 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 15:43:59 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 15:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:59 INFO - Successfully installed psutil 15:43:59 INFO - Cleaning up... 15:43:59 INFO - Return code: 0 15:43:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:43:59 INFO - Using env: {'DISPLAY': ':0', 15:43:59 INFO - 'HOME': '/home/cltbld', 15:43:59 INFO - 'LANG': 'en_US.UTF-8', 15:43:59 INFO - 'LANGUAGE': 'en_US:en', 15:43:59 INFO - 'LOGNAME': 'cltbld', 15:43:59 INFO - 'MAIL': '/var/mail/cltbld', 15:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:59 INFO - 'MOZ_NO_REMOTE': '1', 15:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:59 INFO - 'NO_EM_RESTART': '1', 15:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:59 INFO - 'PWD': '/builds/slave/test', 15:43:59 INFO - 'SHELL': '/bin/bash', 15:43:59 INFO - 'SHLVL': '1', 15:43:59 INFO - 'TERM': 'linux', 15:43:59 INFO - 'TMOUT': '86400', 15:43:59 INFO - 'USER': 'cltbld', 15:43:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:59 INFO - '_': '/tools/buildbot/bin/python'} 15:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:44:00 INFO - Installing collected packages: mozsystemmonitor 15:44:00 INFO - Running setup.py install for mozsystemmonitor 15:44:01 INFO - Successfully installed mozsystemmonitor 15:44:01 INFO - Cleaning up... 15:44:01 INFO - Return code: 0 15:44:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:44:01 INFO - Using env: {'DISPLAY': ':0', 15:44:01 INFO - 'HOME': '/home/cltbld', 15:44:01 INFO - 'LANG': 'en_US.UTF-8', 15:44:01 INFO - 'LANGUAGE': 'en_US:en', 15:44:01 INFO - 'LOGNAME': 'cltbld', 15:44:01 INFO - 'MAIL': '/var/mail/cltbld', 15:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:01 INFO - 'MOZ_NO_REMOTE': '1', 15:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:01 INFO - 'NO_EM_RESTART': '1', 15:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:01 INFO - 'PWD': '/builds/slave/test', 15:44:01 INFO - 'SHELL': '/bin/bash', 15:44:01 INFO - 'SHLVL': '1', 15:44:01 INFO - 'TERM': 'linux', 15:44:01 INFO - 'TMOUT': '86400', 15:44:01 INFO - 'USER': 'cltbld', 15:44:01 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:01 INFO - '_': '/tools/buildbot/bin/python'} 15:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:44: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 15:44: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 15:44: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 15:44: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 15:44:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:03 INFO - warning: no files found matching '*.txt' 15:44:03 INFO - no previously-included directories found matching 'build' 15:44:03 INFO - no previously-included directories found matching 'dist' 15:44:03 INFO - no previously-included directories found matching '.git*' 15:44:03 INFO - Installing collected packages: jsonschema, functools32 15:44:03 INFO - Running setup.py install for functools32 15:44:03 INFO - warning: no files found matching '*.txt' 15:44:03 INFO - no previously-included directories found matching 'build' 15:44:03 INFO - no previously-included directories found matching 'dist' 15:44:03 INFO - no previously-included directories found matching '.git*' 15:44:04 INFO - Successfully installed jsonschema functools32 15:44:04 INFO - Cleaning up... 15:44:04 INFO - Return code: 0 15:44:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:04 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:04 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 15:44:04 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 15:44:04 INFO - Using env: {'DISPLAY': ':0', 15:44:04 INFO - 'HOME': '/home/cltbld', 15:44:04 INFO - 'LANG': 'en_US.UTF-8', 15:44:04 INFO - 'LANGUAGE': 'en_US:en', 15:44:04 INFO - 'LOGNAME': 'cltbld', 15:44:04 INFO - 'MAIL': '/var/mail/cltbld', 15:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:04 INFO - 'MOZ_NO_REMOTE': '1', 15:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:04 INFO - 'NO_EM_RESTART': '1', 15:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:04 INFO - 'PWD': '/builds/slave/test', 15:44:04 INFO - 'SHELL': '/bin/bash', 15:44:04 INFO - 'SHLVL': '1', 15:44:04 INFO - 'TERM': 'linux', 15:44:04 INFO - 'TMOUT': '86400', 15:44:04 INFO - 'USER': 'cltbld', 15:44:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:04 INFO - '_': '/tools/buildbot/bin/python'} 15:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:44:04 INFO - Cleaning up... 15:44:04 INFO - Return code: 0 15:44:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:04 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:04 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 15:44:04 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 15:44:04 INFO - Using env: {'DISPLAY': ':0', 15:44:04 INFO - 'HOME': '/home/cltbld', 15:44:04 INFO - 'LANG': 'en_US.UTF-8', 15:44:04 INFO - 'LANGUAGE': 'en_US:en', 15:44:04 INFO - 'LOGNAME': 'cltbld', 15:44:04 INFO - 'MAIL': '/var/mail/cltbld', 15:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:04 INFO - 'MOZ_NO_REMOTE': '1', 15:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:04 INFO - 'NO_EM_RESTART': '1', 15:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:04 INFO - 'PWD': '/builds/slave/test', 15:44:04 INFO - 'SHELL': '/bin/bash', 15:44:04 INFO - 'SHLVL': '1', 15:44:04 INFO - 'TERM': 'linux', 15:44:04 INFO - 'TMOUT': '86400', 15:44:04 INFO - 'USER': 'cltbld', 15:44:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:04 INFO - '_': '/tools/buildbot/bin/python'} 15:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:04 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 15:44:04 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 15:44:04 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 15:44:04 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 15:44:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:05 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 15:44:05 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 15:44:05 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 15:44:05 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 15:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:05 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 15:44:05 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 15:44:05 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 15:44:05 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 15:44:06 INFO - Downloading docopt-0.6.1.tar.gz 15:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:06 INFO - Running setup.py install for blobuploader 15:44:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:06 INFO - Running setup.py install for requests 15:44:06 INFO - Running setup.py install for docopt 15:44:06 INFO - Successfully installed blobuploader requests docopt 15:44:06 INFO - Cleaning up... 15:44:06 INFO - Return code: 0 15:44:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:06 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:06 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 15:44:06 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 15:44:06 INFO - Using env: {'DISPLAY': ':0', 15:44:06 INFO - 'HOME': '/home/cltbld', 15:44:06 INFO - 'LANG': 'en_US.UTF-8', 15:44:06 INFO - 'LANGUAGE': 'en_US:en', 15:44:06 INFO - 'LOGNAME': 'cltbld', 15:44:06 INFO - 'MAIL': '/var/mail/cltbld', 15:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:06 INFO - 'MOZ_NO_REMOTE': '1', 15:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:06 INFO - 'NO_EM_RESTART': '1', 15:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:06 INFO - 'PWD': '/builds/slave/test', 15:44:06 INFO - 'SHELL': '/bin/bash', 15:44:06 INFO - 'SHLVL': '1', 15:44:06 INFO - 'TERM': 'linux', 15:44:06 INFO - 'TMOUT': '86400', 15:44:06 INFO - 'USER': 'cltbld', 15:44:06 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:06 INFO - '_': '/tools/buildbot/bin/python'} 15:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:07 INFO - Running setup.py (path:/tmp/pip-EGBdaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:07 INFO - Running setup.py (path:/tmp/pip-w9xjBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:07 INFO - Running setup.py (path:/tmp/pip-E4mw79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:07 INFO - Running setup.py (path:/tmp/pip-Yz3Os6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:07 INFO - Running setup.py (path:/tmp/pip-eGzehM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:07 INFO - Running setup.py (path:/tmp/pip-s4qx7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:07 INFO - Running setup.py (path:/tmp/pip-kJa3Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:07 INFO - Running setup.py (path:/tmp/pip-ZntkUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:07 INFO - Running setup.py (path:/tmp/pip-4oBFpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:07 INFO - Running setup.py (path:/tmp/pip-Qb2ryI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:07 INFO - Running setup.py (path:/tmp/pip-rhN_Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:07 INFO - Running setup.py (path:/tmp/pip-wqkH8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:07 INFO - Running setup.py (path:/tmp/pip-SRlkem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:07 INFO - Running setup.py (path:/tmp/pip-vgvW4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:07 INFO - Running setup.py (path:/tmp/pip-m4Lyn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:08 INFO - Running setup.py (path:/tmp/pip-t1Jv__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:08 INFO - Running setup.py (path:/tmp/pip-Hj7XgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:08 INFO - Running setup.py install for manifestparser 15:44:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozcrash 15:44:08 INFO - Running setup.py install for mozdebug 15:44:08 INFO - Running setup.py install for mozdevice 15:44:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozfile 15:44:08 INFO - Running setup.py install for mozhttpd 15:44:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozinfo 15:44:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozInstall 15:44:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozleak 15:44:09 INFO - Running setup.py install for mozlog 15:44:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for moznetwork 15:44:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for mozprocess 15:44:09 INFO - Running setup.py install for mozprofile 15:44:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for mozrunner 15:44:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for mozscreenshot 15:44:09 INFO - Running setup.py install for moztest 15:44:09 INFO - Running setup.py install for mozversion 15:44:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:09 INFO - Cleaning up... 15:44:09 INFO - Return code: 0 15:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:09 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:09 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 15:44:09 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 15:44:09 INFO - Using env: {'DISPLAY': ':0', 15:44:09 INFO - 'HOME': '/home/cltbld', 15:44:09 INFO - 'LANG': 'en_US.UTF-8', 15:44:09 INFO - 'LANGUAGE': 'en_US:en', 15:44:09 INFO - 'LOGNAME': 'cltbld', 15:44:09 INFO - 'MAIL': '/var/mail/cltbld', 15:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:09 INFO - 'MOZ_NO_REMOTE': '1', 15:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:09 INFO - 'NO_EM_RESTART': '1', 15:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:09 INFO - 'PWD': '/builds/slave/test', 15:44:09 INFO - 'SHELL': '/bin/bash', 15:44:09 INFO - 'SHLVL': '1', 15:44:09 INFO - 'TERM': 'linux', 15:44:09 INFO - 'TMOUT': '86400', 15:44:09 INFO - 'USER': 'cltbld', 15:44:09 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:09 INFO - '_': '/tools/buildbot/bin/python'} 15:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:10 INFO - Running setup.py (path:/tmp/pip-tAbuFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:10 INFO - Running setup.py (path:/tmp/pip-cL1bu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:10 INFO - Running setup.py (path:/tmp/pip-DsBSyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:10 INFO - Running setup.py (path:/tmp/pip-GJ1n72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:10 INFO - Running setup.py (path:/tmp/pip-Q8Hkh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:10 INFO - Running setup.py (path:/tmp/pip-DaGV5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:10 INFO - Running setup.py (path:/tmp/pip-6ce8Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:10 INFO - Running setup.py (path:/tmp/pip-pT0rQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:10 INFO - Running setup.py (path:/tmp/pip-icYjyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:10 INFO - Running setup.py (path:/tmp/pip-Skoo8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:10 INFO - Running setup.py (path:/tmp/pip-wzSe4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:10 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)) 15:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:10 INFO - Running setup.py (path:/tmp/pip-Ys5Pdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:11 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)) 15:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:11 INFO - Running setup.py (path:/tmp/pip-1XjUZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:11 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)) 15:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:11 INFO - Running setup.py (path:/tmp/pip-z4YQTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:11 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)) 15:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:11 INFO - Running setup.py (path:/tmp/pip-KkGUSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:11 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)) 15:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:11 INFO - Running setup.py (path:/tmp/pip-lTtrnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:11 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)) 15:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:11 INFO - Running setup.py (path:/tmp/pip-ED1DdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:11 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)) 15:44:11 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)) 15:44:11 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)) 15:44:11 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)) 15:44:11 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)) 15:44:11 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)) 15:44:11 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)) 15:44:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:12 INFO - Downloading blessings-1.6.tar.gz 15:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:12 INFO - Installing collected packages: blessings 15:44:12 INFO - Running setup.py install for blessings 15:44:12 INFO - Successfully installed blessings 15:44:12 INFO - Cleaning up... 15:44:12 INFO - Return code: 0 15:44:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:12 INFO - Reading from file tmpfile_stdout 15:44:12 INFO - Current package versions: 15:44:12 INFO - argparse == 1.2.1 15:44:12 INFO - blessings == 1.6 15:44:12 INFO - blobuploader == 1.2.4 15:44:12 INFO - docopt == 0.6.1 15:44:12 INFO - functools32 == 3.2.3-2 15:44:12 INFO - jsonschema == 2.5.1 15:44:12 INFO - manifestparser == 1.1 15:44:12 INFO - mozInstall == 1.13 15:44:12 INFO - mozcrash == 1.0 15:44:12 INFO - mozdebug == 0.1 15:44:12 INFO - mozdevice == 0.51 15:44:12 INFO - mozfile == 1.2 15:44:12 INFO - mozhttpd == 0.7 15:44:12 INFO - mozinfo == 0.10 15:44:12 INFO - mozleak == 0.1 15:44:12 INFO - mozlog == 3.5 15:44:12 INFO - moznetwork == 0.27 15:44:12 INFO - mozprocess == 0.25 15:44:12 INFO - mozprofile == 0.28 15:44:12 INFO - mozrunner == 6.13 15:44:12 INFO - mozscreenshot == 0.1 15:44:12 INFO - mozsystemmonitor == 0.3 15:44:12 INFO - moztest == 0.8 15:44:12 INFO - mozversion == 1.4 15:44:12 INFO - psutil == 3.1.1 15:44:12 INFO - requests == 1.2.3 15:44:12 INFO - wsgiref == 0.1.2 15:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:12 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')]} 15:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:12 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')]} 15:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:12 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:12 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 15:44:12 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 15:44:12 INFO - Using env: {'DISPLAY': ':0', 15:44:12 INFO - 'HOME': '/home/cltbld', 15:44:12 INFO - 'LANG': 'en_US.UTF-8', 15:44:12 INFO - 'LANGUAGE': 'en_US:en', 15:44:12 INFO - 'LOGNAME': 'cltbld', 15:44:12 INFO - 'MAIL': '/var/mail/cltbld', 15:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:12 INFO - 'MOZ_NO_REMOTE': '1', 15:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:12 INFO - 'NO_EM_RESTART': '1', 15:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:12 INFO - 'PWD': '/builds/slave/test', 15:44:12 INFO - 'SHELL': '/bin/bash', 15:44:12 INFO - 'SHLVL': '1', 15:44:12 INFO - 'TERM': 'linux', 15:44:12 INFO - 'TMOUT': '86400', 15:44:12 INFO - 'USER': 'cltbld', 15:44:12 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:12 INFO - '_': '/tools/buildbot/bin/python'} 15:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 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)) 15:44:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:44:14 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)) 15:44:14 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)) 15:44:14 INFO - Installing collected packages: simplejson 15:44:14 INFO - Running setup.py install for simplejson 15:44:14 INFO - building 'simplejson._speedups' extension 15:44:14 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 15:44:15 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 15:44:15 INFO - Successfully installed simplejson 15:44:15 INFO - Cleaning up... 15:44:15 INFO - Return code: 0 15:44:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44:15 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')]} 15:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:15 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')]} 15:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:15 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 0xb081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe759c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, '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': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', '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 15:44:15 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 15:44:15 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 15:44:15 INFO - Using env: {'DISPLAY': ':0', 15:44:15 INFO - 'HOME': '/home/cltbld', 15:44:15 INFO - 'LANG': 'en_US.UTF-8', 15:44:15 INFO - 'LANGUAGE': 'en_US:en', 15:44:15 INFO - 'LOGNAME': 'cltbld', 15:44:15 INFO - 'MAIL': '/var/mail/cltbld', 15:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:15 INFO - 'MOZ_NO_REMOTE': '1', 15:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:15 INFO - 'NO_EM_RESTART': '1', 15:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:15 INFO - 'PWD': '/builds/slave/test', 15:44:15 INFO - 'SHELL': '/bin/bash', 15:44:15 INFO - 'SHLVL': '1', 15:44:15 INFO - 'TERM': 'linux', 15:44:15 INFO - 'TMOUT': '86400', 15:44:15 INFO - 'USER': 'cltbld', 15:44:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:15 INFO - '_': '/tools/buildbot/bin/python'} 15:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:44:15 INFO - Cleaning up... 15:44:15 INFO - Return code: 0 15:44:15 INFO - Running post-action listener: _resource_record_post_action 15:44:15 INFO - Running post-action listener: _start_resource_monitoring 15:44:15 INFO - Starting resource monitoring. 15:44:15 INFO - [mozharness: 2017-09-24 22:44:15.670426Z] Finished create-virtualenv step (success) 15:44:15 INFO - [mozharness: 2017-09-24 22:44:15.670949Z] Running install step. 15:44:15 INFO - Running pre-action listener: _resource_record_pre_action 15:44:15 INFO - Running main action method: install 15:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:15 INFO - Reading from file tmpfile_stdout 15:44:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:44:16 INFO - Reading from file tmpfile_stdout 15:44:16 INFO - Output received: 15:44:16 INFO - Usage: mozinstall [options] installer 15:44:16 INFO - Options: 15:44:16 INFO - -h, --help show this help message and exit 15:44:16 INFO - -d DEST, --destination=DEST 15:44:16 INFO - Directory to install application into. [default: 15:44:16 INFO - "/builds/slave/test"] 15:44:16 INFO - --app=APP Application being installed. [default: firefox] 15:44:16 INFO - mkdir: /builds/slave/test/build/application 15:44:16 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'] 15:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:44:33 INFO - Reading from file tmpfile_stdout 15:44:33 INFO - Output received: 15:44:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:44:33 INFO - Running post-action listener: _resource_record_post_action 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.804086Z] Finished install step (success) 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.804229Z] Running setup-mitmproxy step. 15:44:33 INFO - Running pre-action listener: _resource_record_pre_action 15:44:33 INFO - Running main action method: setup_mitmproxy 15:44:33 INFO - Skipping: mitmproxy is not required 15:44:33 INFO - Running post-action listener: _resource_record_post_action 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.804764Z] Finished setup-mitmproxy step (success) 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.804868Z] Running run-tests step. 15:44:33 INFO - Running pre-action listener: _resource_record_pre_action 15:44:33 INFO - Running pre-action listener: _set_gcov_prefix 15:44:33 INFO - Running main action method: run_tests 15:44:33 WARNING - Try message not found. 15:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:33 INFO - Python 2.7.3 15:44:33 INFO - Return code: 0 15:44:33 INFO - grabbing minidump binary from tooltool 15:44:33 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')]} 15:44:33 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 0xe72d60>, '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 0xe73a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe73ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:33 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 15:44:33 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 15:44:33 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 15:44:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:33 INFO - Return code: 0 15:44:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:44:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:33 INFO - ENV: RUST_BACKTRACE is now full 15:44:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:44:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:33 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/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 15:44:33 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/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 15:44:33 INFO - Using env: {'DISPLAY': ':0', 15:44:33 INFO - 'HOME': '/home/cltbld', 15:44:33 INFO - 'LANG': 'en_US.UTF-8', 15:44:33 INFO - 'LANGUAGE': 'en_US:en', 15:44:33 INFO - 'LOGNAME': 'cltbld', 15:44:33 INFO - 'MAIL': '/var/mail/cltbld', 15:44:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:33 INFO - 'MOZ_NO_REMOTE': '1', 15:44:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:33 INFO - 'NO_EM_RESTART': '1', 15:44:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:33 INFO - 'PWD': '/builds/slave/test', 15:44:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:33 INFO - 'RUST_BACKTRACE': 'full', 15:44:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:33 INFO - 'SHELL': '/bin/bash', 15:44:33 INFO - 'SHLVL': '1', 15:44:33 INFO - 'TERM': 'linux', 15:44:33 INFO - 'TMOUT': '86400', 15:44:33 INFO - 'USER': 'cltbld', 15:44:33 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:33 INFO - '_': '/tools/buildbot/bin/python'} 15:44:33 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/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 15:44:34 INFO - mozversion application_buildid: 20170924215251 15:44:34 INFO - mozversion application_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:34 INFO - mozversion application_display_name: Nightly 15:44:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:34 INFO - mozversion application_name: Firefox 15:44:34 INFO - mozversion application_remotingname: firefox 15:44:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:34 INFO - mozversion application_vendor: Mozilla 15:44:34 INFO - mozversion application_version: 58.0a1 15:44:34 INFO - mozversion platform_buildid: 20170924215251 15:44:34 INFO - mozversion platform_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:34 INFO - mozversion platform_version: 58.0a1 15:44:34 INFO - using testdate: 1506293074 15:44:34 INFO - actual date: 1506293074 15:44:34 INFO - starting webserver on 'localhost:44137' 15:44:34 INFO - SUITE-START | Running 2 tests 15:44:34 INFO - TEST-START | dromaeo_css 15:44:34 INFO - Initialising browser for dromaeo_css test... 15:44:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44137/getInfo.html -profile /tmp/tmpVb4HRN/profile 15:44:34 INFO - TEST-INFO | started process 8951 (/builds/slave/test/build/application/firefox/firefox http://localhost:44137/getInfo.html) 15:44:40 INFO - TEST-INFO | 8951: exit 0 15:44:40 INFO - Browser initialized. 15:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:40 INFO - Using env: {'DISPLAY': ':0', 15:44:40 INFO - 'HOME': '/home/cltbld', 15:44:40 INFO - 'JSGC_DISABLE_POISONING': '1', 15:44:40 INFO - 'LANG': 'en_US.UTF-8', 15:44:40 INFO - 'LANGUAGE': 'en_US:en', 15:44:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:44:40 INFO - 'LOGNAME': 'cltbld', 15:44:40 INFO - 'MAIL': '/var/mail/cltbld', 15:44:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:40 INFO - 'MOZ_CRASHREPORTER': '1', 15:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:44:40 INFO - 'MOZ_NO_REMOTE': '1', 15:44:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:40 INFO - 'NO_EM_RESTART': '1', 15:44:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:40 INFO - 'PWD': '/builds/slave/test', 15:44:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:40 INFO - 'RUST_BACKTRACE': 'full', 15:44:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:40 INFO - 'SHELL': '/bin/bash', 15:44:40 INFO - 'SHLVL': '1', 15:44:40 INFO - 'TERM': 'linux', 15:44:40 INFO - 'TMOUT': '86400', 15:44:40 INFO - 'USER': 'cltbld', 15:44:40 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 15:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:40 INFO - '_': '/tools/buildbot/bin/python'} 15:44:40 INFO - TEST-INFO | started process 9190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVb4HRN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:41 INFO - PID 9190 | 15:44:41 INFO - PID 9190 | (/builds/slave/test/build/application/firefox/firefox:9239): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:44:41 INFO - PID 9190 | 15:44:51 INFO - PID 9190 | RSS: Main: 147808256 15:44:51 INFO - PID 9190 | 15:47:49 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44137/tests/dromaeo/cssquery-ext.html) 15:47:50 INFO - PID 9190 | RSS: Main: 151846912 15:47:50 INFO - PID 9190 | 15:50:51 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-ext.html (next: http://localhost:44137/tests/dromaeo/cssquery-jquery.html) 15:50:52 INFO - PID 9190 | RSS: Main: 151703552 15:50:52 INFO - PID 9190 | 15:53:54 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44137/tests/dromaeo/cssquery-mootools.html) 15:53:54 INFO - PID 9190 | RSS: Main: 153616384 15:53:54 INFO - PID 9190 | 15:56:56 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44137/tests/dromaeo/cssquery-prototype.html) 15:56:57 INFO - PID 9190 | RSS: Main: 152780800 15:56:57 INFO - PID 9190 | 16:00:00 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44137/tests/dromaeo/cssquery-yui.html) 16:00:00 INFO - PID 9190 | RSS: Main: 153407488 16:00:00 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-yui.html (next: http://localhost:44137/tests/dromaeo/cssquery-dojo.html) 16:03:02 INFO - PID 9190 | RSS: Main: 157044736 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | __start_tp_report 16:03:02 INFO - PID 9190 | _x_x_mozilla_page_load 16:03:02 INFO - PID 9190 | _x_x_mozilla_page_load_details 16:03:02 INFO - PID 9190 | |i|pagename|runs| 16:03:02 INFO - PID 9190 | |0;dojo.html;3121.968780312197;3131.7181453669164;3146.4493713600114;3165.5726476925606;3188.0754581171464;6322.841928951767;6375.234971803378;6388.393102655246;6426.389492998163;6497.675116244187;6375.075614035962;6413.551051426402;6415.871682566346;6435.034744788272;6443.677816109199;5915.615484993462;5958.940410595893;5987.670678112702;6005;6006.669633170174;1264.9559532570877;5845.912311315334;5969.761209551612;5993.970030149865;6036.75852965883;5501.779928802843;5823.126531020381;5830.387809280028;5960.493358064569;5968.820935371946;5869.325027621835;5902.852428689274;5951.49412299955;5961.970190149022;5974.074018527135;5876.500497457721;5885.028970219909;5942.138389933479;5955.225820643289;5965.105234214859;6398.58409203405;6399.36006399361;6410.871782564369;6465.3534646535445;6531.412172904462;6739.494537909627;6840.555363901331;6863.10779598649;6899.344562266577;6985.266547012541;6897.172339319263;6924.4114250288785;7006.684699188549;7007.894881576781;7031;6269.7178626961895;6380.266269379034;6424.935750642528;6484.383983521558;6507.772227972046;7094.148702155774;7101.431885449152;7108.644567771591;7129.679164437613;7172.246914074051;6742.966285168641;6755.49333799967;6804.55770374924;6835.179778426521;6848.7260509580055;6714.328567143344;6827.52207345491;6833.965830170917;6835.043093966849;6850.38346548813;6799.626020568916;6813;6820.31796820314;6824.18109826824;6930.410915072174;6868.210155832044;6961.547499412623;6963.547369421073;6964;6966;5172.405173405032;5175.83085181609;5239.554637855825;5240.109181439165;5243.292155558951;4509.27851543758;4521.525239849834;4551.294549344857;4594.47163576193;4605.125026245069;5720.971395142998;5764.855878603068;5769.9711501442225;5830.62100963436;5862.970685146547;6782.8304292392095;6978.720851165896;6981.184891928034;6983.755568555076;6993.755218567326;5792.247007888947;5814.476697097197;5862.824115276463;5865.032269675541;5871.001929671966;5716.714164291769;5868.413158684098;5879.706014699248;5943.762249509971;5953.79161729346;6621.238557565942;6644.501662375341;6645.66771661415;6671.733130674718;6694.83262918431;6777.966110169417;6862.142232220973;6959.338862808025;6963.61700106499;6964.025036494895;6515.153030106056;6519.837004074936;6569.540132190892;6609.900851487136;6613.371729685672;6584.341565843377;6713.966430167818;6715.630640314829;6794.558353706993;6813.693383797642;6871.862562748617;6991.300869912968;6996.965015174892;7003;7012.7545535906;6520.250171230369;6643.60138391698;6656.068150459037;6706.396424321834;6760.898586521108;6656.134702488645;6712.765053223114;6743.325667433413;6747.966260168668;6756;6569.770058048137;6598.241202261801;6604.306547812411;6666.899996500153;6674.599524028574;6596;6634.336566343327;6717;6752.189737231563;6809.557378770364;6330.936690633035;6475.125858009297;6481.287058423664;6556.016597510221;6575.4410875076155 16:03:02 INFO - PID 9190 | |1;ext.html;758.4235980654704;768.2739810878718;805.5448671500602;808.6644042722271;810.92296231858;41358.793206033966;42624.78687606566;42649.57350426495;42650.78674606627;42772;41031.794841025825;41722.582774172246;41769;41813;41822.58177418225;7985.4809437386675;8126.146754590742;8129.349652027853;8135.227153420446;8136.430449868482;8068.798280042987;8160.143184965582;8197.79505512361;8199.344052475788;8199.508029518218;8181.345492360597;8193;8217.958910205441;8252.422330436842;8259.132791056943;8134.633941472648;8135.511869287832;8140.877886831702;8147.633356498972;8190.017197936256;7909.446338756289;7970.08344040437;7971.441999060068;7974.5215287082965;7981.241782030698;37933.620663793285;38279.8086009571;38328;38357.61642383569;38461.80769096164;3485.146139195888;3509.0350153707936;3510.947335789965;3514.5958214805114;3514.68367846895;31585.36829263402;31625;31625.36749265025;31637.52543711846;31640.841795791104;4989.151844186497;5173.793048278064;5221.791128354861;5242.056429842627;5249.527542521153;185405.0729746356;186149;186277;186369.0681546597;186964;44921.10157796826;45568.54431455643;45729.31406028912;49594.25608615873;50911;52488.737556312735;52598.21102683463;52754;52770.20844687333;53049.469505304456;15839.208039597974;16018.439354622533;16046.438374656831;16228.432004879773;16360.67278654444;12892.226466411857;12986.35068246584;13015.154014988995;13017.674558135934;13021.934890325489;14740.41038358475;14844.70310593782;14880.479183228752;15049;15075.472358467621;6004.729787159501;6064.06007068905;6066.211392519032;6081.118237855486;6091.695415229221;993.4982833669095;1015.9586423915546;1028.5680014393972;1032.6127702111708;1037.170263788981;23093.307200784002;23110;23347.416314592272;23351.649725254134;23775.881120594287;1117.1677100560134;1118.4072441605963;1122.8989390954853;1123.5000424811044;1128.542940109257;12221.08341874363;12311.815322770166;12324.691882702824;12444.81332780009;12445.60964547198;227177;229768;230353;230400;230428;52953;54806.177907331425;58237;58363.708181458824;58394.12408813871;1413.724323756878;1465;1467.5010496431264;1470.4559313054024;1473.506375364265;27207.319817004733;27424;27708.307292317048;28066.2983425416;28112.29719257035;38255;38729.41905871358;38746;38767.22465550729;38785;207675;209378;209393;209438;210092;33837.66162338345;34848.47727284143;35166.82416588003;35745.82127089348;35810.82094589614;41725.58274417217;43554;43938.12123757571;44073.338899917166;44360.55639443564;30665.386692266475;31409.371812564077;31416.214594635316;31441;31735.682643173273;30940.381192376477;31158.844205778827;31194.532082018333;31291.217719557193;31572.36855262836;35964.64035359613;35986;36041.639583604876;36046.27907441784;36351.63648363482;30451.695483044885;30483.390332193674;30756.231094222825;31027.069187924397;31577.526337104504;23039.07843686234;23184.18855340055;23373.649395258744;23435.76564234336;23764.52470950606 16:03:02 INFO - PID 9190 | |2;jquery.html;590.660370287085;597.5697497801582;603.5986069263939;609.6984827160924;617.0682269772643;21898.343049708514;22493;22545.083667888208;22590.77409225907;22691.886540567273;22828.429289267737;24207.15274965372;24382.146624868088;24440;24576.75423245767;6529.2817790043055;6700.731970721165;6714.496412769037;6722.394984451398;6745.628990405526;6348.30168681447;6590.571612845174;6662.733490660367;6673.532852700313;6700.899486507707;6613.834654133637;6620.470362371023;6626.834329141761;6628.635425051621;6642.103316052344;6282.717277722513;6583.440407565363;6619.30497297784;6621;6632.469402447792;6098.786542470993;6110.236220472441;6114.633122012693;6114.663693496856;6118.663473508956;28194.859025704944;28453.57319640207;28490.572641410396;28508.429831403464;28511.857440712873;1965.7247985282072;1984.900754962246;1989.7612286525564;1995.2418081129224;1997.510609900569;18594.907025464785;18925.05374731258;19221.13504892283;19225.519362015923;19445.416637500897;2326.627739561679;2330.0446816805197;2340.7659234076627;2367.7277113132036;2396.616541353375;123453.38273308576;128004;137642.3117884414;145130.27434862757;145157;14659.748553182828;15111.23995941275;15204.239788010555;15261.465848695465;15351.923240383727;23622.64566031511;23654.408639784142;23667.644985325234;23705.170319039094;23757.16849910245;10016.14862736661;10141.087302142843;10166.847497287547;10201.846972295421;10236.129928956123;9368.812623747486;9408.576614052246;9475.952620236993;9493.0981556752;9541.713748587554;9018.323625728097;9029.187373136318;9097.13577210164;9205.171534561921;9310.906890931004;2818.478581462436;2856.5429531275313;2867.799254052238;2889.1043776429374;2969.613950186505;955.8136163448061;972.7665360313615;973.7614284500202;990.2127808392202;1014.629660174046;18963.33628323002;19137.521561960784;19139;19261.518462038563;19596;1023.5189460953488;1041.7760181561;1042.3224903812581;1045.4683888103964;1047;10189.286749927434;10472.842907356397;10519.84220236697;10570.41862697559;10686.946565267124;455840;470456;477720;488155;488255;102858;105592.47203763932;107503;110237.44881275542;113207.43396282966;1054.2304117993908;1111.1000089927186;1153.8615366156116;1162.1748558523543;1220.0361714245646;19848.90075549613;20119.99400030022;20219.69670454915;20383.286584969454;20545.48636284105;54607.45392546183;56539.71730141323;57079.71460142673;57560;58653.12020319784;69025.30974690188;69869;70350;71121.6443917777;71579.64210178916;14119.788203177166;14466;14514.34685439179;14522.636934076732;14536.636584085483;22519.437014074778;22672.773272267066;22742.431439214153;23042.654360184275;23233.535329293656;17864.91067544654;18267.812592181464;18301.26794928188;18360;18510.444686659423;15723.764143537628;15980.360785568448;16163.353465861233;16453.670926581643;16698.165091745122;18654.813451865306;18857.339993100177;18859.811401886356;18917.43247702571;18938.337158199396;14268.857311426753;14338.139711617336;14343.641408964859;14364.712705745618;14400.567982960529;16966.23651935641;17995.2801887923;18266.086695664897;18377.264909403475;18402.81597184011 16:03:02 INFO - PID 9190 | |3;mootools.html;1305.2364366845395;1411.9929400352996;1417.4967886400327;1420.9697968972503;1439.8560143985603;15015.324310406031;15632.452864149756;15635.296411661488;15653.765193522106;15671.29479173437;15279.312430940607;15449.995750276224;15469.690606187869;15495.612609684735;15510.68978620427;2834.4472827798586;2885.6537215534167;2918.6497620285595;2919.0513083247924;2920.5619157126494;2784.8886044558194;2834.3339315260896;2843.9289017774513;2855.5002874496986;2855.52883774177;2580.161447529551;2846.3595690969573;2864.412795376953;2865.684774674784;2871.052552657618;2851.5009873272197;2857.6999415061327;2892.9421411571757;2896.333843216051;2901.86941587628;2723.087765598527;2752.876120574579;2753.3942532642786;2757.47607954488;2763;15039.172845493493;15420.306086226146;15445.0732956023;15460.45888393912;15471.767923481157;8268.8346233075;8541.871871921863;8545.658173673108;8578;8587.141285871425;5315.760790764425;5404.621676482648;5459.590530710213;5501.394846566875;5531.861703457405;1979.5743915058188;1993.2425678242175;2012.909419076145;2042.7446569178853;2057.1565658080117;26778.464430711276;27181.45637087247;27940;27978;27984.580231296546;7102.351041625637;7118.110236220473;7201.044283919668;7222.3860971817985;7268.890966635505;17631.735523967152;17702.557436064202;17731;17744.11279436023;17760.200790964438;8121.634526446206;8327.250547450638;8356.456830306011;8392.034915984617;8396.748097557083;7643.847123057508;7674.270944260398;7728.420368472387;7799.3760499159935;7810.570418626917;5386.461353864583;5502.257195278587;5617.21359009739;5746.856328591819;5774.018416869142;1590.3559058581293;1599.5921040134924;1607.3008241414789;1610.2431857027414;1632.3715369582558;891.140049851896;905.5743800413927;911.2482202183226;913.4154141349542;922.1470140120362;7445.181030086686;7521.323080922633;7551;7578.962105189439;7603.809904752426;730.652939853576;737.3216640690578;737.5500944423898;741.1661880384568;746.1866565443693;4446.777661116996;4505.098980203907;4660.347551342815;5079.619028572872;5210.270562121306;21437.785622143892;22186.112555497923;22347.55304893893;22734.772652273266;22809.201677941193;22293.777062229172;22347.44131396728;22350.44123896883;22454.887725561268;22612.773872261067;10324.174066074696;10994.395308258123;11104.389258590694;11345.432728363548;11618.70953226176;7926.960365198137;7972.720954766555;8097.473664211808;8326.616714926804;8435.114312997048;18729.625407492047;18925;19192.808071919102;19372.70940935915;19395.418137455898;18567.44297671072;19760.90119549393;19969;20158.39524814258;20164.193432262546;11438.656840294805;11542.884571154182;11545.499085118881;11561.768764624829;11570.074394048625;12903.483860645469;14327.78508322355;14450.85549144495;14463.059901106395;14500.637484062983;10999.780004400027;11020.44897755093;11247.268927519684;11247.66257012291;11371.658850234506;10814.621488247874;10860;10987.725306867393;11110.333379997226;11353.943230284127;8785.25325347327;8917.821643567222;8924;8928.330375221754;8935.106489351012;6795.72817087311;6879.449644028366;6902.275261097512;6912.861742765016;6943.132108486439;6764.289749576224;6804;6835.07726456922;6861.519693621399;6887.896681549681 16:03:02 INFO - PID 9190 | |4;prototype.html;504.5635525270641;511.6495200787461;537.3202898333607;538.7656369479275;547.8548184731047;6175.444210021097;6375.744970201192;6379.553431259814;6451.290358060615;6453.322401147871;6061.272647282332;6140.649057207418;6151.692415379235;6178.474829639486;6179.5983261087995;5009.674371165881;5036.4459909410025;5038.874028149289;5080.060188865072;5091.159958606844;4826.758662066883;5028.7737051832755;5030.748462576875;5050.949490505084;5060.367454068241;4943.258511223327;5003.39959204896;5013.548780609744;5059.49405059493;5093.363329583802;4952.87617809554;4986.725730084844;5009.071507469614;5019.64862459628;5040.16837221858;4575.084983003413;4583.175028494869;4586.059857729158;4587.655925805578;4613.146567884918;6186.628802271833;6193.411625895533;6204.627722336674;6258;6282.371762823726;5741.224934633813;5772.3361813391575;5794.62334948227;5820.534357251409;5820.941790582082;6592.439642630382;6594.439472644831;6664.966675166642;6685.832854178636;6687.632180230085;4938.530839570235;4960.702357858504;4988.501149884983;4999.8000079996755;5015.689644834391;6877.759278425231;6922;6922.757703480404;7011.228764835864;7055.435565154827;5034.672746271481;5072.54347108762;5077.8730531737;5125.1799712045895;5128.102582048126;5202;5209.765560549784;5221.477852214824;5226.320578324793;5231.267622532849;5684.488396044376;5706.429357064343;5709.200711900337;5780.248567686174;5818.301803783573;6407.743690252338;6556.934430655728;6636.402723754885;6663.766768163091;6686.19765628118;1666.7166581681142;1754.6666133434608;1761.339497688367;1775.3076300242915;1778.2975724588714;1212.1636071111081;1222.6454328244708;1235.2773627427875;1241.962741117768;1263.387257180267;5675;5683.635927377482;5745.971270143623;5749.683767392834;5855.3851845556455;6763.628000460022;6839.829004274833;6898.689558969859;6939.375456208965;6987.371136597731;5752.9424705753245;5753.51095156908;5761.567882408753;5787.160861675034;5798.768049277982;3491.8079505627434;3536.8231588420476;3555.1823080691584;3613.2954073955325;3652.726045546595;6646.833829154213;6648.33516648341;6679.9332006679315;6686.796376652249;6705.329467053353;6988.266232045562;7030.156381234182;7032.6132062736015;7073.893891591631;7128.752468318024;6599.439047681001;6612.627559944367;6633.966830165915;6693.230278517935;6695.698693558801;6612.23959244693;6685.8328541784895;6751.527393082437;6770.830729231809;6830.897536537055;6627.569208001464;6681.596864658476;6718.330760121668;6749.291324411062;6751.966240168767;6461.903071453838;6523.586273078991;6548.967255163694;6574.572652777554;6615.437687796399;5006.799728010838;5007.899842003067;5008.899822003613;5029.84910452687;5069.541272482769;6589.341065893373;6694.497912656473;6835.624040677811;6882.621455819978;6961.2342642308295;6036.366181550874;6398.71205795731;6402.8474874523035;6508.316626754123;6573.868522629617;6495.512836537373;6526.151600291932;6540.934590654033;6593.736250549924;6694.861873481423;6261.587434847927;6401.167848179894;6457;6524.282328943717;6572.65260621581;6658.700358483783;6721.294264102395;6730.764423245163;6786.253512113763;6789.660516974231;6333.556651034383;6408.455281301141;6454.354564543508;6461.450776684034;6468.223813142453 16:03:02 INFO - PID 9190 | |5;yui.html;928.1321963963692;928.7585227840764;930.7766136127332;943.0475220027774;951.8762560867086;19364.3222487213;19673.21307147714;19798.703019454682;19841.60316793663;19901.900490497563;18284.177212025457;18450.53873653156;18465.261389544437;18549.072546372696;18580.07099645016;962.9133377995979;964.0648570886265;973.2262851033446;977.2231076294363;978.1832170137943;994.368575954267;996.6960077176494;999.215615741643;999.2455695949548;1002.4987506246877;1003.6888564544978;1041.9010194031555;1049.1554298789472;1050.0497050169608;1051.75283808305;1029.9073083422454;1031.6131450705984;1035.254616675992;1035.3632516002679;1037.08218226869;728.3444899590411;752.6274494125443;757.6287619066618;758.3629751009179;760.2739383888429;17724.29102835898;17769.555761105945;17783.288668453246;17833.821661783346;17863.910680446643;22201.777982220134;22203.000864961115;22473.213437529772;22484;22658;17509.212085456056;17629.647407051787;17728.822711772846;17743.73384399235;17809.910950445294;3733.5706393764794;3776.848926042955;3776.9244615107546;3778.527684039495;3779.4708740776314;101430.4135304529;136773;137580;137897.31051344678;141753;16854.747178792328;17741.645167096587;17770.822291777175;17805.643887122184;17830.10849457522;28303.575446368322;30521.84739076335;30604.54093188604;30649.38701225963;31127.533087003714;8915.197632213132;9139.086091390807;9175.816483670289;9192.770180745534;9199.908000920039;4209.34755112958;4319.935200971988;4321.178975994551;4340.717853339523;4342.848000319974;5496.945030549723;5568.276124103922;5599.944000559943;5601.915971260434;5632.324121105494;1056.37145898192;1086.4947799273375;1109.4951796932376;1112.8330750387345;1117.2402766118955;701.4178232067372;701.9824504387329;709.0675761373777;715.8496715689763;721.7257442171941;10216.693499195037;10751.40867252293;11295.830562541569;11797;12076.275423474619;625.0936142593167;627.7677259414046;628.9025201093838;629.0846817879974;640.8429934665943;5298.337707786527;5329.653572517774;5379;5420.91868621971;5428.022955867903;122931;123922.38038809749;124178;125785;127123.3643831775;101621.49189254007;103665.48167259115;104830;107215;107982.46008769906;92124.53937730269;93067;95525.5223723877;95532.52233738787;95820;9911.157551608194;9990.550425231027;10137.341072830242;10220.693379198636;10312;42694.78652606841;43484.347734784635;44243.33634995413;44962.77518612386;46127.53872461232;58109;58292;58414.7079264601;59842;60252.69873650779;15505.844941550891;15761.211939403212;15992.760108598613;16001.919990399974;16007.279672414536;17589.208485618434;17759.556011099827;17816.10919454048;17822.821771782117;18045.278188872297;15000.774988374966;15055.322510486836;15250.237488125327;15333.080015199124;15389.692206156038;16185.352585896433;16291;16387.754183687015;16528.586785330463;16537;14824.851751482347;14943.476978305707;14946.701065978838;15111.924440378167;15118.168500732565;11232.55069797199;11304.378259195822;11346.432678366215;11429.371384573597;11727.237729547553;12639.241645501299;12650.620481385573;12770.872291276968;12943.029272804766;13043.869561304266 16:03:02 INFO - PID 9190 | __end_tp_report 16:03:02 INFO - PID 9190 | __start_cc_report 16:03:02 INFO - PID 9190 | _x_x_mozilla_cycle_collect,269 16:03:02 INFO - PID 9190 | __end_cc_report 16:03:02 INFO - PID 9190 | __startTimestamp1506294182625__endTimestamp 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | ------- Summary: start ------- 16:03:02 INFO - PID 9190 | Number of tests: 6 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#0] dojo.html Cycles:165 Average:6275.15 Median:6569.54 stddev:883.73 (13.5%) stddev-sans-first:851.11 16:03:02 INFO - PID 9190 | Values: 3122.0 3131.7 3146.4 3165.6 3188.1 6322.8 6375.2 6388.4 6426.4 6497.7 6375.1 6413.6 6415.9 6435.0 6443.7 5915.6 5958.9 5987.7 6005.0 6006.7 1265.0 5845.9 5969.8 5994.0 6036.8 5501.8 5823.1 5830.4 5960.5 5968.8 5869.3 5902.9 5951.5 5962.0 5974.1 5876.5 5885.0 5942.1 5955.2 5965.1 6398.6 6399.4 6410.9 6465.4 6531.4 6739.5 6840.6 6863.1 6899.3 6985.3 6897.2 6924.4 7006.7 7007.9 7031.0 6269.7 6380.3 6424.9 6484.4 6507.8 7094.1 7101.4 7108.6 7129.7 7172.2 6743.0 6755.5 6804.6 6835.2 6848.7 6714.3 6827.5 6834.0 6835.0 6850.4 6799.6 6813.0 6820.3 6824.2 6930.4 6868.2 6961.5 6963.5 6964.0 6966.0 5172.4 5175.8 5239.6 5240.1 5243.3 4509.3 4521.5 4551.3 4594.5 4605.1 5721.0 5764.9 5770.0 5830.6 5863.0 6782.8 6978.7 6981.2 6983.8 6993.8 5792.2 5814.5 5862.8 5865.0 5871.0 5716.7 5868.4 5879.7 5943.8 5953.8 6621.2 6644.5 6645.7 6671.7 6694.8 6778.0 6862.1 6959.3 6963.6 6964.0 6515.2 6519.8 6569.5 6609.9 6613.4 6584.3 6714.0 6715.6 6794.6 6813.7 6871.9 6991.3 6997.0 7003.0 7012.8 6520.3 6643.6 6656.1 6706.4 6760.9 6656.1 6712.8 6743.3 6748.0 6756.0 6569.8 6598.2 6604.3 6666.9 6674.6 6596.0 6634.3 6717.0 6752.2 6809.6 6330.9 6475.1 6481.3 6556.0 6575.4 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#1] ext.html Cycles:180 Average:38135.47 Median:19340.75 stddev:54144.66 (280.0%) stddev-sans-first:54223.81 16:03:02 INFO - PID 9190 | Values: 758.4 768.3 805.5 808.7 810.9 41358.8 42624.8 42649.6 42650.8 42772.0 41031.8 41722.6 41769.0 41813.0 41822.6 7985.5 8126.1 8129.3 8135.2 8136.4 8068.8 8160.1 8197.8 8199.3 8199.5 8181.3 8193.0 8218.0 8252.4 8259.1 8134.6 8135.5 8140.9 8147.6 8190.0 7909.4 7970.1 7971.4 7974.5 7981.2 37933.6 38279.8 38328.0 38357.6 38461.8 3485.1 3509.0 3510.9 3514.6 3514.7 31585.4 31625.0 31625.4 31637.5 31640.8 4989.2 5173.8 5221.8 5242.1 5249.5 185405.1 186149.0 186277.0 186369.1 186964.0 44921.1 45568.5 45729.3 49594.3 50911.0 52488.7 52598.2 52754.0 52770.2 53049.5 15839.2 16018.4 16046.4 16228.4 16360.7 12892.2 12986.4 13015.2 13017.7 13021.9 14740.4 14844.7 14880.5 15049.0 15075.5 6004.7 6064.1 6066.2 6081.1 6091.7 993.5 1016.0 1028.6 1032.6 1037.2 23093.3 23110.0 23347.4 23351.6 23775.9 1117.2 1118.4 1122.9 1123.5 1128.5 12221.1 12311.8 12324.7 12444.8 12445.6 227177.0 229768.0 230353.0 230400.0 230428.0 52953.0 54806.2 58237.0 58363.7 58394.1 1413.7 1465.0 1467.5 1470.5 1473.5 27207.3 27424.0 27708.3 28066.3 28112.3 38255.0 38729.4 38746.0 38767.2 38785.0 207675.0 209378.0 209393.0 209438.0 210092.0 33837.7 34848.5 35166.8 35745.8 35810.8 41725.6 43554.0 43938.1 44073.3 44360.6 30665.4 31409.4 31416.2 31441.0 31735.7 30940.4 31158.8 31194.5 31291.2 31572.4 35964.6 35986.0 36041.6 36046.3 36351.6 30451.7 30483.4 30756.2 31027.1 31577.5 23039.1 23184.2 23373.6 23435.8 23764.5 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#2] jquery.html Cycles:180 Average:34030.93 Median:22631.77 stddev:80180.40 (354.3%) stddev-sans-first:80366.02 16:03:02 INFO - PID 9190 | Values: 590.7 597.6 603.6 609.7 617.1 21898.3 22493.0 22545.1 22590.8 22691.9 22828.4 24207.2 24382.1 24440.0 24576.8 6529.3 6700.7 6714.5 6722.4 6745.6 6348.3 6590.6 6662.7 6673.5 6700.9 6613.8 6620.5 6626.8 6628.6 6642.1 6282.7 6583.4 6619.3 6621.0 6632.5 6098.8 6110.2 6114.6 6114.7 6118.7 28194.9 28453.6 28490.6 28508.4 28511.9 1965.7 1984.9 1989.8 1995.2 1997.5 18594.9 18925.1 19221.1 19225.5 19445.4 2326.6 2330.0 2340.8 2367.7 2396.6 123453.4 128004.0 137642.3 145130.3 145157.0 14659.7 15111.2 15204.2 15261.5 15351.9 23622.6 23654.4 23667.6 23705.2 23757.2 10016.1 10141.1 10166.8 10201.8 10236.1 9368.8 9408.6 9476.0 9493.1 9541.7 9018.3 9029.2 9097.1 9205.2 9310.9 2818.5 2856.5 2867.8 2889.1 2969.6 955.8 972.8 973.8 990.2 1014.6 18963.3 19137.5 19139.0 19261.5 19596.0 1023.5 1041.8 1042.3 1045.5 1047.0 10189.3 10472.8 10519.8 10570.4 10686.9 455840.0 470456.0 477720.0 488155.0 488255.0 102858.0 105592.5 107503.0 110237.4 113207.4 1054.2 1111.1 1153.9 1162.2 1220.0 19848.9 20120.0 20219.7 20383.3 20545.5 54607.5 56539.7 57079.7 57560.0 58653.1 69025.3 69869.0 70350.0 71121.6 71579.6 14119.8 14466.0 14514.3 14522.6 14536.6 22519.4 22672.8 22742.4 23042.7 23233.5 17864.9 18267.8 18301.3 18360.0 18510.4 15723.8 15980.4 16163.4 16453.7 16698.2 18654.8 18857.3 18859.8 18917.4 18938.3 14268.9 14338.1 14343.6 14364.7 14400.6 16966.2 17995.3 18266.1 18377.3 18402.8 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#3] mootools.html Cycles:180 Average:9467.49 Median:27981.29 stddev:6899.82 (24.7%) stddev-sans-first:6891.92 16:03:02 INFO - PID 9190 | Values: 1305.2 1412.0 1417.5 1421.0 1439.9 15015.3 15632.5 15635.3 15653.8 15671.3 15279.3 15450.0 15469.7 15495.6 15510.7 2834.4 2885.7 2918.6 2919.1 2920.6 2784.9 2834.3 2843.9 2855.5 2855.5 2580.2 2846.4 2864.4 2865.7 2871.1 2851.5 2857.7 2892.9 2896.3 2901.9 2723.1 2752.9 2753.4 2757.5 2763.0 15039.2 15420.3 15445.1 15460.5 15471.8 8268.8 8541.9 8545.7 8578.0 8587.1 5315.8 5404.6 5459.6 5501.4 5531.9 1979.6 1993.2 2012.9 2042.7 2057.2 26778.5 27181.5 27940.0 27978.0 27984.6 7102.4 7118.1 7201.0 7222.4 7268.9 17631.7 17702.6 17731.0 17744.1 17760.2 8121.6 8327.3 8356.5 8392.0 8396.7 7643.8 7674.3 7728.4 7799.4 7810.6 5386.5 5502.3 5617.2 5746.9 5774.0 1590.4 1599.6 1607.3 1610.2 1632.4 891.1 905.6 911.2 913.4 922.1 7445.2 7521.3 7551.0 7579.0 7603.8 730.7 737.3 737.6 741.2 746.2 4446.8 4505.1 4660.3 5079.6 5210.3 21437.8 22186.1 22347.6 22734.8 22809.2 22293.8 22347.4 22350.4 22454.9 22612.8 10324.2 10994.4 11104.4 11345.4 11618.7 7927.0 7972.7 8097.5 8326.6 8435.1 18729.6 18925.0 19192.8 19372.7 19395.4 18567.4 19760.9 19969.0 20158.4 20164.2 11438.7 11542.9 11545.5 11561.8 11570.1 12903.5 14327.8 14450.9 14463.1 14500.6 10999.8 11020.4 11247.3 11247.7 11371.7 10814.6 10860.0 10987.7 11110.3 11353.9 8785.3 8917.8 8924.0 8928.3 8935.1 6795.7 6879.4 6902.3 6912.9 6943.1 6764.3 6804.0 6835.1 6861.5 6887.9 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#4] prototype.html Cycles:180 Average:5572.67 Median:6179.04 stddev:1565.38 (25.3%) stddev-sans-first:1522.85 16:03:02 INFO - PID 9190 | Values: 504.6 511.6 537.3 538.8 547.9 6175.4 6375.7 6379.6 6451.3 6453.3 6061.3 6140.6 6151.7 6178.5 6179.6 5009.7 5036.4 5038.9 5080.1 5091.2 4826.8 5028.8 5030.7 5050.9 5060.4 4943.3 5003.4 5013.5 5059.5 5093.4 4952.9 4986.7 5009.1 5019.6 5040.2 4575.1 4583.2 4586.1 4587.7 4613.1 6186.6 6193.4 6204.6 6258.0 6282.4 5741.2 5772.3 5794.6 5820.5 5820.9 6592.4 6594.4 6665.0 6685.8 6687.6 4938.5 4960.7 4988.5 4999.8 5015.7 6877.8 6922.0 6922.8 7011.2 7055.4 5034.7 5072.5 5077.9 5125.2 5128.1 5202.0 5209.8 5221.5 5226.3 5231.3 5684.5 5706.4 5709.2 5780.2 5818.3 6407.7 6556.9 6636.4 6663.8 6686.2 1666.7 1754.7 1761.3 1775.3 1778.3 1212.2 1222.6 1235.3 1242.0 1263.4 5675.0 5683.6 5746.0 5749.7 5855.4 6763.6 6839.8 6898.7 6939.4 6987.4 5752.9 5753.5 5761.6 5787.2 5798.8 3491.8 3536.8 3555.2 3613.3 3652.7 6646.8 6648.3 6679.9 6686.8 6705.3 6988.3 7030.2 7032.6 7073.9 7128.8 6599.4 6612.6 6634.0 6693.2 6695.7 6612.2 6685.8 6751.5 6770.8 6830.9 6627.6 6681.6 6718.3 6749.3 6752.0 6461.9 6523.6 6549.0 6574.6 6615.4 5006.8 5007.9 5008.9 5029.8 5069.5 6589.3 6694.5 6835.6 6882.6 6961.2 6036.4 6398.7 6402.8 6508.3 6573.9 6495.5 6526.2 6540.9 6593.7 6694.9 6261.6 6401.2 6457.0 6524.3 6572.7 6658.7 6721.3 6730.8 6786.3 6789.7 6333.6 6408.5 6454.4 6461.5 6468.2 16:03:02 INFO - PID 9190 | 16:03:02 INFO - PID 9190 | [#5] yui.html Cycles:180 Average:24018.41 Median:18457.90 stddev:34537.22 (187.1%) stddev-sans-first:34590.59 16:03:02 INFO - PID 9190 | Values: 928.1 928.8 930.8 943.0 951.9 19364.3 19673.2 19798.7 19841.6 19901.9 18284.2 18450.5 18465.3 18549.1 18580.1 962.9 964.1 973.2 977.2 978.2 994.4 996.7 999.2 999.2 1002.5 1003.7 1041.9 1049.2 1050.0 1051.8 1029.9 1031.6 1035.3 1035.4 1037.1 728.3 752.6 757.6 758.4 760.3 17724.3 17769.6 17783.3 17833.8 17863.9 22201.8 22203.0 22473.2 22484.0 22658.0 17509.2 17629.6 17728.8 17743.7 17809.9 3733.6 3776.8 3776.9 3778.5 3779.5 101430.4 136773.0 137580.0 137897.3 141753.0 16854.7 17741.6 17770.8 17805.6 17830.1 28303.6 30521.8 30604.5 30649.4 31127.5 8915.2 9139.1 9175.8 9192.8 9199.9 4209.3 4319.9 4321.2 4340.7 4342.8 5496.9 5568.3 5599.9 5601.9 5632.3 1056.4 1086.5 1109.5 1112.8 1117.2 701.4 702.0 709.1 715.8 721.7 10216.7 10751.4 11295.8 11797.0 12076.3 625.1 627.8 628.9 629.1 640.8 5298.3 5329.7 5379.0 5420.9 5428.0 122931.0 123922.4 124178.0 125785.0 127123.4 101621.5 103665.5 104830.0 107215.0 107982.5 92124.5 93067.0 95525.5 95532.5 95820.0 9911.2 9990.6 10137.3 10220.7 10312.0 42694.8 43484.3 44243.3 44962.8 46127.5 58109.0 58292.0 58414.7 59842.0 60252.7 15505.8 15761.2 15992.8 16001.9 16007.3 17589.2 17759.6 17816.1 17822.8 18045.3 15000.8 15055.3 15250.2 15333.1 15389.7 16185.4 16291.0 16387.8 16528.6 16537.0 14824.9 14943.5 14946.7 15111.9 15118.2 11232.6 11304.4 11346.4 11429.4 11727.2 12639.2 12650.6 12770.9 12943.0 13043.9 16:03:02 INFO - PID 9190 | -------- Summary: end -------- 16:03:02 INFO - PID 9190 | 16:03:03 INFO - TEST-INFO | 9190: exit 0 16:03:03 INFO - TEST-OK | dromaeo_css | took 1109170ms 16:03:03 INFO - TEST-START | kraken 16:03:03 INFO - Initialising browser for kraken test... 16:03:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44137/getInfo.html -profile /tmp/tmplkJH27/profile 16:03:03 INFO - TEST-INFO | started process 9561 (/builds/slave/test/build/application/firefox/firefox http://localhost:44137/getInfo.html) 16:03:08 INFO - TEST-INFO | 9561: exit 0 16:03:08 INFO - Browser initialized. 16:03:08 INFO - Running cycle 1/1 for kraken test... 16:03:08 INFO - Using env: {'DISPLAY': ':0', 16:03:08 INFO - 'HOME': '/home/cltbld', 16:03:08 INFO - 'JSGC_DISABLE_POISONING': '1', 16:03:08 INFO - 'LANG': 'en_US.UTF-8', 16:03:08 INFO - 'LANGUAGE': 'en_US:en', 16:03:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:03:08 INFO - 'LOGNAME': 'cltbld', 16:03:08 INFO - 'MAIL': '/var/mail/cltbld', 16:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:08 INFO - 'MOZ_CRASHREPORTER': '1', 16:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:03:08 INFO - 'MOZ_NO_REMOTE': '1', 16:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:08 INFO - 'NO_EM_RESTART': '1', 16:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:08 INFO - 'PWD': '/builds/slave/test', 16:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:08 INFO - 'RUST_BACKTRACE': 'full', 16:03:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:03:08 INFO - 'SHELL': '/bin/bash', 16:03:08 INFO - 'SHLVL': '1', 16:03:08 INFO - 'TERM': 'linux', 16:03:08 INFO - 'TMOUT': '86400', 16:03:08 INFO - 'USER': 'cltbld', 16:03:08 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624', 16:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:08 INFO - '_': '/tools/buildbot/bin/python'} 16:03:08 INFO - TEST-INFO | started process 9793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkJH27/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:09 INFO - PID 9793 | 16:03:09 INFO - PID 9793 | (/builds/slave/test/build/application/firefox/firefox:9842): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:03:09 INFO - PID 9793 | 16:03:19 INFO - PID 9793 | RSS: Main: 152920064 16:03:19 INFO - PID 9793 | 16:03:22 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:23 INFO - PID 9793 | RSS: Main: 159277056 16:03:23 INFO - PID 9793 | 16:03:26 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-dft) 16:03:26 INFO - PID 9793 | RSS: Main: 159412224 16:03:26 INFO - PID 9793 | 16:03:29 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-fft) 16:03:30 INFO - PID 9793 | RSS: Main: 156090368 16:03:30 INFO - PID 9793 | 16:03:32 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator) 16:03:32 INFO - PID 9793 | RSS: Main: 156786688 16:03:32 INFO - PID 9793 | 16:03:35 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:35 INFO - PID 9793 | RSS: Main: 157220864 16:03:35 INFO - PID 9793 | 16:03:38 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:39 INFO - PID 9793 | RSS: Main: 159035392 16:03:39 INFO - PID 9793 | 16:03:43 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:43 INFO - PID 9793 | RSS: Main: 158547968 16:03:43 INFO - PID 9793 | 16:03:46 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial) 16:03:47 INFO - PID 9793 | RSS: Main: 159375360 16:03:47 INFO - PID 9793 | 16:03:49 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:49 INFO - PID 9793 | RSS: Main: 159330304 16:03:49 INFO - PID 9793 | 16:03:51 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:51 INFO - PID 9793 | RSS: Main: 159428608 16:03:51 INFO - PID 9793 | 16:03:54 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:54 INFO - PID 9793 | RSS: Main: 156401664 16:03:54 INFO - PID 9793 | 16:03:57 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:57 INFO - PID 9793 | RSS: Main: 156672000 16:03:57 INFO - PID 9793 | 16:04:00 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:01 INFO - PID 9793 | RSS: Main: 156676096 16:04:01 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44137/tests/kraken/driver.html?testName=ai-astar) 16:04:03 INFO - PID 9793 | RSS: Main: 158318592 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | __start_tp_report 16:04:03 INFO - PID 9793 | _x_x_mozilla_page_load 16:04:03 INFO - PID 9793 | _x_x_mozilla_page_load_details 16:04:03 INFO - PID 9793 | |i|pagename|runs| 16:04:03 INFO - PID 9793 | |0;ai-astar;108;106;108;106;106;110;108;108;107;107 16:04:03 INFO - PID 9793 | |1;audio-beat-detection;123;118;116;117;116;120;121;120;116;116 16:04:03 INFO - PID 9793 | |2;audio-dft;165;163;165;162;165;168;166;169;168;165 16:04:03 INFO - PID 9793 | |3;audio-fft;75;74;74;80;73;74;74;73;75;76 16:04:03 INFO - PID 9793 | |4;audio-oscillator;79;79;78;79;79;80;79;94;79;80 16:04:03 INFO - PID 9793 | |5;imaging-gaussian-blur;114;115;114;113;114;114;114;114;115;115 16:04:03 INFO - PID 9793 | |6;imaging-darkroom;149;149;149;148;148;148;148;148;148;151 16:04:03 INFO - PID 9793 | |7;imaging-desaturate;95;95;95;94;94;94;94;94;95;95 16:04:03 INFO - PID 9793 | |8;json-parse-financial;59;57;57;58;56;54;56;57;54;56 16:04:03 INFO - PID 9793 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 16:04:03 INFO - PID 9793 | |10;stanford-crypto-aes;76;74;72;77;75;77;73;75;73;75 16:04:03 INFO - PID 9793 | |11;stanford-crypto-ccm;111;114;110;107;118;112;117;110;120;119 16:04:03 INFO - PID 9793 | |12;stanford-crypto-pbkdf2;168;169;166;175;171;174;167;182;176;165 16:04:03 INFO - PID 9793 | |13;stanford-crypto-sha256-iterative;73;65;67;69;64;64;66;65;65;71 16:04:03 INFO - PID 9793 | __end_tp_report 16:04:03 INFO - PID 9793 | __start_cc_report 16:04:03 INFO - PID 9793 | _x_x_mozilla_cycle_collect,735 16:04:03 INFO - PID 9793 | __end_cc_report 16:04:03 INFO - PID 9793 | __startTimestamp1506294243568__endTimestamp 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | ------- Summary: start ------- 16:04:03 INFO - PID 9793 | Number of tests: 14 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#0] ai-astar Cycles:10 Average:107.40 Median:108.00 stddev:1.26 (1.2%) stddev-sans-first:1.32 16:04:03 INFO - PID 9793 | Values: 108.0 106.0 108.0 106.0 106.0 110.0 108.0 108.0 107.0 107.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:119.00 stddev:2.54 (2.1%) stddev-sans-first:2.05 16:04:03 INFO - PID 9793 | Values: 123.0 118.0 116.0 117.0 116.0 120.0 121.0 120.0 116.0 116.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.22 (1.3%) stddev-sans-first:2.35 16:04:03 INFO - PID 9793 | Values: 165.0 163.0 165.0 162.0 165.0 168.0 166.0 169.0 168.0 165.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.50 stddev:2.04 (2.7%) stddev-sans-first:2.17 16:04:03 INFO - PID 9793 | Values: 75.0 74.0 74.0 80.0 73.0 74.0 74.0 73.0 75.0 76.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:79.00 stddev:4.74 (6.0%) stddev-sans-first:4.99 16:04:03 INFO - PID 9793 | Values: 79.0 79.0 78.0 79.0 79.0 80.0 79.0 94.0 79.0 80.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:04:03 INFO - PID 9793 | Values: 114.0 115.0 114.0 113.0 114.0 114.0 114.0 114.0 115.0 115.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 16:04:03 INFO - PID 9793 | Values: 149.0 149.0 149.0 148.0 148.0 148.0 148.0 148.0 148.0 151.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:04:03 INFO - PID 9793 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.36 16:04:03 INFO - PID 9793 | Values: 59.0 57.0 57.0 58.0 56.0 54.0 56.0 57.0 54.0 56.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:04:03 INFO - PID 9793 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:1.70 (2.3%) stddev-sans-first:1.74 16:04:03 INFO - PID 9793 | Values: 76.0 74.0 72.0 77.0 75.0 77.0 73.0 75.0 73.0 75.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:115.50 stddev:4.47 (3.9%) stddev-sans-first:4.62 16:04:03 INFO - PID 9793 | Values: 111.0 114.0 110.0 107.0 118.0 112.0 117.0 110.0 120.0 119.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.50 stddev:5.38 (3.1%) stddev-sans-first:5.57 16:04:03 INFO - PID 9793 | Values: 168.0 169.0 166.0 175.0 171.0 174.0 167.0 182.0 176.0 165.0 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:3.11 (4.7%) stddev-sans-first:2.39 16:04:03 INFO - PID 9793 | Values: 73.0 65.0 67.0 69.0 64.0 64.0 66.0 65.0 65.0 71.0 16:04:03 INFO - PID 9793 | -------- Summary: end -------- 16:04:03 INFO - PID 9793 | 16:04:03 INFO - PID 9793 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:04:04 INFO - TEST-INFO | 9793: exit 0 16:04:04 INFO - TEST-OK | kraken | took 60862ms 16:04:04 INFO - SUITE-END | took 1170s 16:04:04 INFO - Completed test suite (00:19:30) 16:04:04 INFO - javascript benchmark 16:04:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8569.901503658453, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.968780312197, 3131.7181453669164, 3146.4493713600114, 3165.5726476925606, 3188.0754581171464, 6322.841928951767, 6375.234971803378, 6388.393102655246, 6426.389492998163, 6497.675116244187, 6375.075614035962, 6413.551051426402, 6415.871682566346, 6435.034744788272, 6443.677816109199, 5915.615484993462, 5958.940410595893, 5987.670678112702, 6005.0, 6006.669633170174, 1264.9559532570877, 5845.912311315334, 5969.761209551612, 5993.970030149865, 6036.75852965883, 5501.779928802843, 5823.126531020381, 5830.387809280028, 5960.493358064569, 5968.820935371946, 5869.325027621835, 5902.852428689274, 5951.49412299955, 5961.970190149022, 5974.074018527135, 5876.500497457721, 5885.028970219909, 5942.138389933479, 5955.225820643289, 5965.105234214859, 6398.58409203405, 6399.36006399361, 6410.871782564369, 6465.3534646535445, 6531.412172904462, 6739.494537909627, 6840.555363901331, 6863.10779598649, 6899.344562266577, 6985.266547012541, 6897.172339319263, 6924.4114250288785, 7006.684699188549, 7007.894881576781, 7031.0, 6269.7178626961895, 6380.266269379034, 6424.935750642528, 6484.383983521558, 6507.772227972046, 7094.148702155774, 7101.431885449152, 7108.644567771591, 7129.679164437613, 7172.246914074051, 6742.966285168641, 6755.49333799967, 6804.55770374924, 6835.179778426521, 6848.7260509580055, 6714.328567143344, 6827.52207345491, 6833.965830170917, 6835.043093966849, 6850.38346548813, 6799.626020568916, 6813.0, 6820.31796820314, 6824.18109826824, 6930.410915072174, 6868.210155832044, 6961.547499412623, 6963.547369421073, 6964.0, 6966.0, 5172.405173405032, 5175.83085181609, 5239.554637855825, 5240.109181439165, 5243.292155558951, 4509.27851543758, 4521.525239849834, 4551.294549344857, 4594.47163576193, 4605.125026245069, 5720.971395142998, 5764.855878603068, 5769.9711501442225, 5830.62100963436, 5862.970685146547, 6782.8304292392095, 6978.720851165896, 6981.184891928034, 6983.755568555076, 6993.755218567326, 5792.247007888947, 5814.476697097197, 5862.824115276463, 5865.032269675541, 5871.001929671966, 5716.714164291769, 5868.413158684098, 5879.706014699248, 5943.762249509971, 5953.79161729346, 6621.238557565942, 6644.501662375341, 6645.66771661415, 6671.733130674718, 6694.83262918431, 6777.966110169417, 6862.142232220973, 6959.338862808025, 6963.61700106499, 6964.025036494895, 6515.153030106056, 6519.837004074936, 6569.540132190892, 6609.900851487136, 6613.371729685672, 6584.341565843377, 6713.966430167818, 6715.630640314829, 6794.558353706993, 6813.693383797642, 6871.862562748617, 6991.300869912968, 6996.965015174892, 7003.0, 7012.7545535906, 6520.250171230369, 6643.60138391698, 6656.068150459037, 6706.396424321834, 6760.898586521108, 6656.134702488645, 6712.765053223114, 6743.325667433413, 6747.966260168668, 6756.0, 6569.770058048137, 6598.241202261801, 6604.306547812411, 6666.899996500153, 6674.599524028574, 6596.0, 6634.336566343327, 6717.0, 6752.189737231563, 6809.557378770364, 6330.936690633035, 6475.125858009297, 6481.287058423664, 6556.016597510221, 6575.4410875076155], "value": 6207.817315536922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.4235980654704, 768.2739810878718, 805.5448671500602, 808.6644042722271, 810.92296231858, 41358.793206033966, 42624.78687606566, 42649.57350426495, 42650.78674606627, 42772.0, 41031.794841025825, 41722.582774172246, 41769.0, 41813.0, 41822.58177418225, 7985.4809437386675, 8126.146754590742, 8129.349652027853, 8135.227153420446, 8136.430449868482, 8068.798280042987, 8160.143184965582, 8197.79505512361, 8199.344052475788, 8199.508029518218, 8181.345492360597, 8193.0, 8217.958910205441, 8252.422330436842, 8259.132791056943, 8134.633941472648, 8135.511869287832, 8140.877886831702, 8147.633356498972, 8190.017197936256, 7909.446338756289, 7970.08344040437, 7971.441999060068, 7974.5215287082965, 7981.241782030698, 37933.620663793285, 38279.8086009571, 38328.0, 38357.61642383569, 38461.80769096164, 3485.146139195888, 3509.0350153707936, 3510.947335789965, 3514.5958214805114, 3514.68367846895, 31585.36829263402, 31625.0, 31625.36749265025, 31637.52543711846, 31640.841795791104, 4989.151844186497, 5173.793048278064, 5221.791128354861, 5242.056429842627, 5249.527542521153, 185405.0729746356, 186149.0, 186277.0, 186369.0681546597, 186964.0, 44921.10157796826, 45568.54431455643, 45729.31406028912, 49594.25608615873, 50911.0, 52488.737556312735, 52598.21102683463, 52754.0, 52770.20844687333, 53049.469505304456, 15839.208039597974, 16018.439354622533, 16046.438374656831, 16228.432004879773, 16360.67278654444, 12892.226466411857, 12986.35068246584, 13015.154014988995, 13017.674558135934, 13021.934890325489, 14740.41038358475, 14844.70310593782, 14880.479183228752, 15049.0, 15075.472358467621, 6004.729787159501, 6064.06007068905, 6066.211392519032, 6081.118237855486, 6091.695415229221, 993.4982833669095, 1015.9586423915546, 1028.5680014393972, 1032.6127702111708, 1037.170263788981, 23093.307200784002, 23110.0, 23347.416314592272, 23351.649725254134, 23775.881120594287, 1117.1677100560134, 1118.4072441605963, 1122.8989390954853, 1123.5000424811044, 1128.542940109257, 12221.08341874363, 12311.815322770166, 12324.691882702824, 12444.81332780009, 12445.60964547198, 227177.0, 229768.0, 230353.0, 230400.0, 230428.0, 52953.0, 54806.177907331425, 58237.0, 58363.708181458824, 58394.12408813871, 1413.724323756878, 1465.0, 1467.5010496431264, 1470.4559313054024, 1473.506375364265, 27207.319817004733, 27424.0, 27708.307292317048, 28066.2983425416, 28112.29719257035, 38255.0, 38729.41905871358, 38746.0, 38767.22465550729, 38785.0, 207675.0, 209378.0, 209393.0, 209438.0, 210092.0, 33837.66162338345, 34848.47727284143, 35166.82416588003, 35745.82127089348, 35810.82094589614, 41725.58274417217, 43554.0, 43938.12123757571, 44073.338899917166, 44360.55639443564, 30665.386692266475, 31409.371812564077, 31416.214594635316, 31441.0, 31735.682643173273, 30940.381192376477, 31158.844205778827, 31194.532082018333, 31291.217719557193, 31572.36855262836, 35964.64035359613, 35986.0, 36041.639583604876, 36046.27907441784, 36351.63648363482, 30451.695483044885, 30483.390332193674, 30756.231094222825, 31027.069187924397, 31577.526337104504, 23039.07843686234, 23184.18855340055, 23373.649395258744, 23435.76564234336, 23764.52470950606], "value": 17462.477898089768, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.660370287085, 597.5697497801582, 603.5986069263939, 609.6984827160924, 617.0682269772643, 21898.343049708514, 22493.0, 22545.083667888208, 22590.77409225907, 22691.886540567273, 22828.429289267737, 24207.15274965372, 24382.146624868088, 24440.0, 24576.75423245767, 6529.2817790043055, 6700.731970721165, 6714.496412769037, 6722.394984451398, 6745.628990405526, 6348.30168681447, 6590.571612845174, 6662.733490660367, 6673.532852700313, 6700.899486507707, 6613.834654133637, 6620.470362371023, 6626.834329141761, 6628.635425051621, 6642.103316052344, 6282.717277722513, 6583.440407565363, 6619.30497297784, 6621.0, 6632.469402447792, 6098.786542470993, 6110.236220472441, 6114.633122012693, 6114.663693496856, 6118.663473508956, 28194.859025704944, 28453.57319640207, 28490.572641410396, 28508.429831403464, 28511.857440712873, 1965.7247985282072, 1984.900754962246, 1989.7612286525564, 1995.2418081129224, 1997.510609900569, 18594.907025464785, 18925.05374731258, 19221.13504892283, 19225.519362015923, 19445.416637500897, 2326.627739561679, 2330.0446816805197, 2340.7659234076627, 2367.7277113132036, 2396.616541353375, 123453.38273308576, 128004.0, 137642.3117884414, 145130.27434862757, 145157.0, 14659.748553182828, 15111.23995941275, 15204.239788010555, 15261.465848695465, 15351.923240383727, 23622.64566031511, 23654.408639784142, 23667.644985325234, 23705.170319039094, 23757.16849910245, 10016.14862736661, 10141.087302142843, 10166.847497287547, 10201.846972295421, 10236.129928956123, 9368.812623747486, 9408.576614052246, 9475.952620236993, 9493.0981556752, 9541.713748587554, 9018.323625728097, 9029.187373136318, 9097.13577210164, 9205.171534561921, 9310.906890931004, 2818.478581462436, 2856.5429531275313, 2867.799254052238, 2889.1043776429374, 2969.613950186505, 955.8136163448061, 972.7665360313615, 973.7614284500202, 990.2127808392202, 1014.629660174046, 18963.33628323002, 19137.521561960784, 19139.0, 19261.518462038563, 19596.0, 1023.5189460953488, 1041.7760181561, 1042.3224903812581, 1045.4683888103964, 1047.0, 10189.286749927434, 10472.842907356397, 10519.84220236697, 10570.41862697559, 10686.946565267124, 455840.0, 470456.0, 477720.0, 488155.0, 488255.0, 102858.0, 105592.47203763932, 107503.0, 110237.44881275542, 113207.43396282966, 1054.2304117993908, 1111.1000089927186, 1153.8615366156116, 1162.1748558523543, 1220.0361714245646, 19848.90075549613, 20119.99400030022, 20219.69670454915, 20383.286584969454, 20545.48636284105, 54607.45392546183, 56539.71730141323, 57079.71460142673, 57560.0, 58653.12020319784, 69025.30974690188, 69869.0, 70350.0, 71121.6443917777, 71579.64210178916, 14119.788203177166, 14466.0, 14514.34685439179, 14522.636934076732, 14536.636584085483, 22519.437014074778, 22672.773272267066, 22742.431439214153, 23042.654360184275, 23233.535329293656, 17864.91067544654, 18267.812592181464, 18301.26794928188, 18360.0, 18510.444686659423, 15723.764143537628, 15980.360785568448, 16163.353465861233, 16453.670926581643, 16698.165091745122, 18654.813451865306, 18857.339993100177, 18859.811401886356, 18917.43247702571, 18938.337158199396, 14268.857311426753, 14338.139711617336, 14343.641408964859, 14364.712705745618, 14400.567982960529, 16966.23651935641, 17995.2801887923, 18266.086695664897, 18377.264909403475, 18402.81597184011], "value": 11917.485052804885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.2364366845395, 1411.9929400352996, 1417.4967886400327, 1420.9697968972503, 1439.8560143985603, 15015.324310406031, 15632.452864149756, 15635.296411661488, 15653.765193522106, 15671.29479173437, 15279.312430940607, 15449.995750276224, 15469.690606187869, 15495.612609684735, 15510.68978620427, 2834.4472827798586, 2885.6537215534167, 2918.6497620285595, 2919.0513083247924, 2920.5619157126494, 2784.8886044558194, 2834.3339315260896, 2843.9289017774513, 2855.5002874496986, 2855.52883774177, 2580.161447529551, 2846.3595690969573, 2864.412795376953, 2865.684774674784, 2871.052552657618, 2851.5009873272197, 2857.6999415061327, 2892.9421411571757, 2896.333843216051, 2901.86941587628, 2723.087765598527, 2752.876120574579, 2753.3942532642786, 2757.47607954488, 2763.0, 15039.172845493493, 15420.306086226146, 15445.0732956023, 15460.45888393912, 15471.767923481157, 8268.8346233075, 8541.871871921863, 8545.658173673108, 8578.0, 8587.141285871425, 5315.760790764425, 5404.621676482648, 5459.590530710213, 5501.394846566875, 5531.861703457405, 1979.5743915058188, 1993.2425678242175, 2012.909419076145, 2042.7446569178853, 2057.1565658080117, 26778.464430711276, 27181.45637087247, 27940.0, 27978.0, 27984.580231296546, 7102.351041625637, 7118.110236220473, 7201.044283919668, 7222.3860971817985, 7268.890966635505, 17631.735523967152, 17702.557436064202, 17731.0, 17744.11279436023, 17760.200790964438, 8121.634526446206, 8327.250547450638, 8356.456830306011, 8392.034915984617, 8396.748097557083, 7643.847123057508, 7674.270944260398, 7728.420368472387, 7799.3760499159935, 7810.570418626917, 5386.461353864583, 5502.257195278587, 5617.21359009739, 5746.856328591819, 5774.018416869142, 1590.3559058581293, 1599.5921040134924, 1607.3008241414789, 1610.2431857027414, 1632.3715369582558, 891.140049851896, 905.5743800413927, 911.2482202183226, 913.4154141349542, 922.1470140120362, 7445.181030086686, 7521.323080922633, 7551.0, 7578.962105189439, 7603.809904752426, 730.652939853576, 737.3216640690578, 737.5500944423898, 741.1661880384568, 746.1866565443693, 4446.777661116996, 4505.098980203907, 4660.347551342815, 5079.619028572872, 5210.270562121306, 21437.785622143892, 22186.112555497923, 22347.55304893893, 22734.772652273266, 22809.201677941193, 22293.777062229172, 22347.44131396728, 22350.44123896883, 22454.887725561268, 22612.773872261067, 10324.174066074696, 10994.395308258123, 11104.389258590694, 11345.432728363548, 11618.70953226176, 7926.960365198137, 7972.720954766555, 8097.473664211808, 8326.616714926804, 8435.114312997048, 18729.625407492047, 18925.0, 19192.808071919102, 19372.70940935915, 19395.418137455898, 18567.44297671072, 19760.90119549393, 19969.0, 20158.39524814258, 20164.193432262546, 11438.656840294805, 11542.884571154182, 11545.499085118881, 11561.768764624829, 11570.074394048625, 12903.483860645469, 14327.78508322355, 14450.85549144495, 14463.059901106395, 14500.637484062983, 10999.780004400027, 11020.44897755093, 11247.268927519684, 11247.66257012291, 11371.658850234506, 10814.621488247874, 10860.0, 10987.725306867393, 11110.333379997226, 11353.943230284127, 8785.25325347327, 8917.821643567222, 8924.0, 8928.330375221754, 8935.106489351012, 6795.72817087311, 6879.449644028366, 6902.275261097512, 6912.861742765016, 6943.132108486439, 6764.289749576224, 6804.0, 6835.07726456922, 6861.519693621399, 6887.896681549681], "value": 6722.986541777497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.5635525270641, 511.6495200787461, 537.3202898333607, 538.7656369479275, 547.8548184731047, 6175.444210021097, 6375.744970201192, 6379.553431259814, 6451.290358060615, 6453.322401147871, 6061.272647282332, 6140.649057207418, 6151.692415379235, 6178.474829639486, 6179.5983261087995, 5009.674371165881, 5036.4459909410025, 5038.874028149289, 5080.060188865072, 5091.159958606844, 4826.758662066883, 5028.7737051832755, 5030.748462576875, 5050.949490505084, 5060.367454068241, 4943.258511223327, 5003.39959204896, 5013.548780609744, 5059.49405059493, 5093.363329583802, 4952.87617809554, 4986.725730084844, 5009.071507469614, 5019.64862459628, 5040.16837221858, 4575.084983003413, 4583.175028494869, 4586.059857729158, 4587.655925805578, 4613.146567884918, 6186.628802271833, 6193.411625895533, 6204.627722336674, 6258.0, 6282.371762823726, 5741.224934633813, 5772.3361813391575, 5794.62334948227, 5820.534357251409, 5820.941790582082, 6592.439642630382, 6594.439472644831, 6664.966675166642, 6685.832854178636, 6687.632180230085, 4938.530839570235, 4960.702357858504, 4988.501149884983, 4999.8000079996755, 5015.689644834391, 6877.759278425231, 6922.0, 6922.757703480404, 7011.228764835864, 7055.435565154827, 5034.672746271481, 5072.54347108762, 5077.8730531737, 5125.1799712045895, 5128.102582048126, 5202.0, 5209.765560549784, 5221.477852214824, 5226.320578324793, 5231.267622532849, 5684.488396044376, 5706.429357064343, 5709.200711900337, 5780.248567686174, 5818.301803783573, 6407.743690252338, 6556.934430655728, 6636.402723754885, 6663.766768163091, 6686.19765628118, 1666.7166581681142, 1754.6666133434608, 1761.339497688367, 1775.3076300242915, 1778.2975724588714, 1212.1636071111081, 1222.6454328244708, 1235.2773627427875, 1241.962741117768, 1263.387257180267, 5675.0, 5683.635927377482, 5745.971270143623, 5749.683767392834, 5855.3851845556455, 6763.628000460022, 6839.829004274833, 6898.689558969859, 6939.375456208965, 6987.371136597731, 5752.9424705753245, 5753.51095156908, 5761.567882408753, 5787.160861675034, 5798.768049277982, 3491.8079505627434, 3536.8231588420476, 3555.1823080691584, 3613.2954073955325, 3652.726045546595, 6646.833829154213, 6648.33516648341, 6679.9332006679315, 6686.796376652249, 6705.329467053353, 6988.266232045562, 7030.156381234182, 7032.6132062736015, 7073.893891591631, 7128.752468318024, 6599.439047681001, 6612.627559944367, 6633.966830165915, 6693.230278517935, 6695.698693558801, 6612.23959244693, 6685.8328541784895, 6751.527393082437, 6770.830729231809, 6830.897536537055, 6627.569208001464, 6681.596864658476, 6718.330760121668, 6749.291324411062, 6751.966240168767, 6461.903071453838, 6523.586273078991, 6548.967255163694, 6574.572652777554, 6615.437687796399, 5006.799728010838, 5007.899842003067, 5008.899822003613, 5029.84910452687, 5069.541272482769, 6589.341065893373, 6694.497912656473, 6835.624040677811, 6882.621455819978, 6961.2342642308295, 6036.366181550874, 6398.71205795731, 6402.8474874523035, 6508.316626754123, 6573.868522629617, 6495.512836537373, 6526.151600291932, 6540.934590654033, 6593.736250549924, 6694.861873481423, 6261.587434847927, 6401.167848179894, 6457.0, 6524.282328943717, 6572.65260621581, 6658.700358483783, 6721.294264102395, 6730.764423245163, 6786.253512113763, 6789.660516974231, 6333.556651034383, 6408.455281301141, 6454.354564543508, 6461.450776684034, 6468.223813142453], "value": 5113.092212993115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.1321963963692, 928.7585227840764, 930.7766136127332, 943.0475220027774, 951.8762560867086, 19364.3222487213, 19673.21307147714, 19798.703019454682, 19841.60316793663, 19901.900490497563, 18284.177212025457, 18450.53873653156, 18465.261389544437, 18549.072546372696, 18580.07099645016, 962.9133377995979, 964.0648570886265, 973.2262851033446, 977.2231076294363, 978.1832170137943, 994.368575954267, 996.6960077176494, 999.215615741643, 999.2455695949548, 1002.4987506246877, 1003.6888564544978, 1041.9010194031555, 1049.1554298789472, 1050.0497050169608, 1051.75283808305, 1029.9073083422454, 1031.6131450705984, 1035.254616675992, 1035.3632516002679, 1037.08218226869, 728.3444899590411, 752.6274494125443, 757.6287619066618, 758.3629751009179, 760.2739383888429, 17724.29102835898, 17769.555761105945, 17783.288668453246, 17833.821661783346, 17863.910680446643, 22201.777982220134, 22203.000864961115, 22473.213437529772, 22484.0, 22658.0, 17509.212085456056, 17629.647407051787, 17728.822711772846, 17743.73384399235, 17809.910950445294, 3733.5706393764794, 3776.848926042955, 3776.9244615107546, 3778.527684039495, 3779.4708740776314, 101430.4135304529, 136773.0, 137580.0, 137897.31051344678, 141753.0, 16854.747178792328, 17741.645167096587, 17770.822291777175, 17805.643887122184, 17830.10849457522, 28303.575446368322, 30521.84739076335, 30604.54093188604, 30649.38701225963, 31127.533087003714, 8915.197632213132, 9139.086091390807, 9175.816483670289, 9192.770180745534, 9199.908000920039, 4209.34755112958, 4319.935200971988, 4321.178975994551, 4340.717853339523, 4342.848000319974, 5496.945030549723, 5568.276124103922, 5599.944000559943, 5601.915971260434, 5632.324121105494, 1056.37145898192, 1086.4947799273375, 1109.4951796932376, 1112.8330750387345, 1117.2402766118955, 701.4178232067372, 701.9824504387329, 709.0675761373777, 715.8496715689763, 721.7257442171941, 10216.693499195037, 10751.40867252293, 11295.830562541569, 11797.0, 12076.275423474619, 625.0936142593167, 627.7677259414046, 628.9025201093838, 629.0846817879974, 640.8429934665943, 5298.337707786527, 5329.653572517774, 5379.0, 5420.91868621971, 5428.022955867903, 122931.0, 123922.38038809749, 124178.0, 125785.0, 127123.3643831775, 101621.49189254007, 103665.48167259115, 104830.0, 107215.0, 107982.46008769906, 92124.53937730269, 93067.0, 95525.5223723877, 95532.52233738787, 95820.0, 9911.157551608194, 9990.550425231027, 10137.341072830242, 10220.693379198636, 10312.0, 42694.78652606841, 43484.347734784635, 44243.33634995413, 44962.77518612386, 46127.53872461232, 58109.0, 58292.0, 58414.7079264601, 59842.0, 60252.69873650779, 15505.844941550891, 15761.211939403212, 15992.760108598613, 16001.919990399974, 16007.279672414536, 17589.208485618434, 17759.556011099827, 17816.10919454048, 17822.821771782117, 18045.278188872297, 15000.774988374966, 15055.322510486836, 15250.237488125327, 15333.080015199124, 15389.692206156038, 16185.352585896433, 16291.0, 16387.754183687015, 16528.586785330463, 16537.0, 14824.851751482347, 14943.476978305707, 14946.701065978838, 15111.924440378167, 15118.168500732565, 11232.55069797199, 11304.378259195822, 11346.432678366215, 11429.371384573597, 11727.237729547553, 12639.241645501299, 12650.620481385573, 12770.872291276968, 12943.029272804766, 13043.869561304266], "value": 8919.782660950255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 108.0, 106.0, 106.0, 110.0, 108.0, 108.0, 107.0, 107.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 116.0, 117.0, 116.0, 120.0, 121.0, 120.0, 116.0, 116.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 162.0, 165.0, 168.0, 166.0, 169.0, 168.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 80.0, 73.0, 74.0, 74.0, 73.0, 75.0, 76.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 80.0, 79.0, 94.0, 79.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 151.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 58.0, 56.0, 54.0, 56.0, 57.0, 54.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 72.0, 77.0, 75.0, 77.0, 73.0, 75.0, 73.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 107.0, 118.0, 112.0, 117.0, 110.0, 120.0, 119.0], "value": 113.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 166.0, 175.0, 171.0, 174.0, 167.0, 182.0, 176.0, 165.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 67.0, 69.0, 64.0, 64.0, 66.0, 65.0, 65.0, 71.0], "value": 66.9, "unit": "score"}]}]} 16:04:04 INFO - Return code: 0 16:04:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:04 INFO - # TBPL SUCCESS # 16:04:04 INFO - Running post-action listener: _package_coverage_data 16:04:04 INFO - Running post-action listener: _resource_record_post_action 16:04:04 INFO - [mozharness: 2017-09-24 23:04:04.344383Z] Finished run-tests step (success) 16:04:04 INFO - Running post-run listener: _resource_record_post_run 16:04:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345194496; Read time: 56; Write time: 247796 16:04:04 INFO - TinderboxPrint: CPU usage
13.1% 16:04:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 56 16:04:04 INFO - TinderboxPrint: I/O write bytes / time
345,194,496 / 247,796 16:04:04 INFO - TinderboxPrint: CPU idle
8,227.3 (86.9%) 16:04:04 INFO - TinderboxPrint: CPU user
1,193.1 (12.6%) 16:04:04 INFO - TinderboxPrint: Swap in / out
0 / 0 16:04:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10133504; Read time: 0; Write time: 1360 16:04:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:04:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 335060992; Read time: 56; Write time: 246436 16:04:04 INFO - Running post-run listener: _upload_blobber_files 16:04:04 INFO - Blob upload gear active. 16:04:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:04 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 16:04:04 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'] 16:04:04 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 16:04:05 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:06 INFO - (blobuploader) - INFO - Done attempting. 16:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:09 INFO - (blobuploader) - INFO - Done attempting. 16:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:10 INFO - (blobuploader) - INFO - Done attempting. 16:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:11 INFO - (blobuploader) - INFO - Done attempting. 16:04:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:11 INFO - Return code: 0 16:04:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1ae83f8471ee606db0186c93e6084cb6cce82bf5b6e4aec7d0c627f995bf3d8f0a2b5886c84d9295d8971839e3fe547211d84573e61cf0361fb1b0a19df7b5a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4deca87fb01b07cecb3dfa9593e8608ab2ea66d6efec84c3ce28bfdd1f8d5fc3429c67c4b540a04117908c8e8c570de6b029f59d4d27d2cd899fdcb425211ad5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab2ce89f0d501ddda1d1ddee6531fbe43c62ca8f80caa2dd311cc65aa68f1dfae680d86c71bc0798a15fe40a40de764886677fe2802b539b0d0af852bc5f03b0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea03089064bd5c5a230bae7c8b19e5b5f8bd8729cd143ede37ddcc8ea6fdbf747009735845ab6fa85c9831b549340bf728ad54226ba05e808f770b245db59e2b"} 16:04:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:11 INFO - Contents: 16:04:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1ae83f8471ee606db0186c93e6084cb6cce82bf5b6e4aec7d0c627f995bf3d8f0a2b5886c84d9295d8971839e3fe547211d84573e61cf0361fb1b0a19df7b5a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4deca87fb01b07cecb3dfa9593e8608ab2ea66d6efec84c3ce28bfdd1f8d5fc3429c67c4b540a04117908c8e8c570de6b029f59d4d27d2cd899fdcb425211ad5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab2ce89f0d501ddda1d1ddee6531fbe43c62ca8f80caa2dd311cc65aa68f1dfae680d86c71bc0798a15fe40a40de764886677fe2802b539b0d0af852bc5f03b0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea03089064bd5c5a230bae7c8b19e5b5f8bd8729cd143ede37ddcc8ea6fdbf747009735845ab6fa85c9831b549340bf728ad54226ba05e808f770b245db59e2b"} 16:04:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:11 INFO - Copying logs to upload dir... 16:04:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.205270 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-24 16:04:11.547445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:11.551539) ========= 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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1ae83f8471ee606db0186c93e6084cb6cce82bf5b6e4aec7d0c627f995bf3d8f0a2b5886c84d9295d8971839e3fe547211d84573e61cf0361fb1b0a19df7b5a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4deca87fb01b07cecb3dfa9593e8608ab2ea66d6efec84c3ce28bfdd1f8d5fc3429c67c4b540a04117908c8e8c570de6b029f59d4d27d2cd899fdcb425211ad5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab2ce89f0d501ddda1d1ddee6531fbe43c62ca8f80caa2dd311cc65aa68f1dfae680d86c71bc0798a15fe40a40de764886677fe2802b539b0d0af852bc5f03b0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea03089064bd5c5a230bae7c8b19e5b5f8bd8729cd143ede37ddcc8ea6fdbf747009735845ab6fa85c9831b549340bf728ad54226ba05e808f770b245db59e2b"} build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1ae83f8471ee606db0186c93e6084cb6cce82bf5b6e4aec7d0c627f995bf3d8f0a2b5886c84d9295d8971839e3fe547211d84573e61cf0361fb1b0a19df7b5a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4deca87fb01b07cecb3dfa9593e8608ab2ea66d6efec84c3ce28bfdd1f8d5fc3429c67c4b540a04117908c8e8c570de6b029f59d4d27d2cd899fdcb425211ad5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab2ce89f0d501ddda1d1ddee6531fbe43c62ca8f80caa2dd311cc65aa68f1dfae680d86c71bc0798a15fe40a40de764886677fe2802b539b0d0af852bc5f03b0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea03089064bd5c5a230bae7c8b19e5b5f8bd8729cd143ede37ddcc8ea6fdbf747009735845ab6fa85c9831b549340bf728ad54226ba05e808f770b245db59e2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:11.580333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:11.580646) ========= 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=ea65d483da93c827905c2090000001f5-1506290424.458395-1992051624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:11.663019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:11.663516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:11.664046) ========= ========= Total master_lag: 0.24 =========