builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1504306132.65 results: success (0) revision: 73e8f351b28ffc30e8077be21ce7298f4648ca5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.651687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.652206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.652484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.669785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.670135) ========= 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=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 15:48:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-09-01 15:48:52 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.786690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.787247) ========= 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=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.836817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:52.837185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73e8f351b28ffc30e8077be21ce7298f4648ca5a --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 73e8f351b28ffc30e8077be21ce7298f4648ca5a --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=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 15:48:52,884 truncating revision to first 12 chars 2017-09-01 15:48:52,884 Setting DEBUG logging. 2017-09-01 15:48:52,884 attempt 1/10 2017-09-01 15:48:52,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73e8f351b28f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 15:48:53,317 unpacking tar archive at: mozilla-central-73e8f351b28f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:53.617306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:53.617648) ========= script_repo_revision: 73e8f351b28ffc30e8077be21ce7298f4648ca5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:53.618059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:53.618329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 15:48:53.631810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-01 15:48:53.632114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:53 INFO - MultiFileLogger online at 20170901 15:48:53 in /builds/slave/test 15:48:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:48:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:53 INFO - {'append_to_log': False, 15:48:53 INFO - 'base_work_dir': '/builds/slave/test', 15:48:53 INFO - 'blob_upload_branch': 'Firefox', 15:48:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:53 INFO - 'branch': 'Firefox', 15:48:53 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:53 INFO - 'code_coverage': False, 15:48:53 INFO - 'config_files': ('talos/linux_config.py',), 15:48:53 INFO - 'default_actions': ('clobber', 15:48:53 INFO - 'read-buildbot-config', 15:48:53 INFO - 'download-and-extract', 15:48:53 INFO - 'populate-webroot', 15:48:53 INFO - 'create-virtualenv', 15:48:53 INFO - 'install', 15:48:53 INFO - 'setup-mitmproxy', 15:48:53 INFO - 'run-tests'), 15:48:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:53 INFO - 'disable_ccov_upload': False, 15:48:53 INFO - 'disable_stylo': False, 15:48:53 INFO - 'download_minidump_stackwalk': True, 15:48:53 INFO - 'download_symbols': 'ondemand', 15:48:53 INFO - 'enable_stylo': False, 15:48:53 INFO - 'enable_webrender': False, 15:48:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:48:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:53 INFO - 'gecko_profile': False, 15:48:53 INFO - 'gecko_profile_interval': 0, 15:48:53 INFO - 'installer_path': 'installer.exe', 15:48:53 INFO - 'log_level': 'info', 15:48:53 INFO - 'log_name': 'talos', 15:48:53 INFO - 'log_to_console': True, 15:48:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:53 INFO - 'opt_config_files': (), 15:48:53 INFO - 'pip_index': False, 15:48:53 INFO - 'suite': 'dromaeojs-e10s', 15:48:53 INFO - 'system_bits': '32', 15:48:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:53 INFO - 'title': 'talos-linux64-ix-072', 15:48:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:53 INFO - 'use_talos_json': True, 15:48:53 INFO - 'verify': 'False', 15:48:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:53 INFO - 'work_dir': 'build'} 15:48:53 INFO - [mozharness: 2017-09-01 22:48:53.815999Z] Running clobber step. 15:48:53 INFO - Running pre-action listener: _resource_record_pre_action 15:48:53 INFO - Running main action method: clobber 15:48:53 INFO - rmtree: /builds/slave/test/build 15:48:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:54 INFO - Running post-action listener: _resource_record_post_action 15:48:54 INFO - [mozharness: 2017-09-01 22:48:54.832246Z] Finished clobber step (success) 15:48:54 INFO - [mozharness: 2017-09-01 22:48:54.832343Z] Running read-buildbot-config step. 15:48:54 INFO - Running pre-action listener: _resource_record_pre_action 15:48:54 INFO - Running main action method: read_buildbot_config 15:48:54 INFO - Using buildbot properties: 15:48:54 INFO - { 15:48:54 INFO - "project": "", 15:48:54 INFO - "product": "firefox", 15:48:54 INFO - "who": "kwierso@gmail.com", 15:48:54 INFO - "installer_path": "public/build/target.tar.bz2", 15:48:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:48:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:48:54 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:48:54 INFO - "stage_platform": "linux64-qr", 15:48:54 INFO - "basedir": "/builds/slave/test", 15:48:54 INFO - "buildnumber": 26, 15:48:54 INFO - "platform": "ubuntu64_hw_qr", 15:48:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:48:54 INFO - "slavebuilddir": "test", 15:48:54 INFO - "taskId": "LxLgly2rTBSuKU1zu-NG9w", 15:48:54 INFO - "branch": "mozilla-central", 15:48:54 INFO - "script_repo_revision": "production", 15:48:54 INFO - "revision": "73e8f351b28ffc30e8077be21ce7298f4648ca5a", 15:48:54 INFO - "slavename": "talos-linux64-ix-072", 15:48:54 INFO - "repo_path": "mozilla-central" 15:48:54 INFO - } 15:48:54 INFO - Finding installer, test and symbols from parent task. 15:48:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxLgly2rTBSuKU1zu-NG9w'}, attempt #1 15:48:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxLgly2rTBSuKU1zu-NG9w'}, attempt #1 15:48:55 INFO - Task dependencies: B3zBBhhZS1Sz7X0NYgNFnw 15:48:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw'}, attempt #1 15:48:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 15:48:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.test_packages.json 15:48:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.crashreporter-symbols.zip 15:48:56 INFO - Running post-action listener: _resource_record_post_action 15:48:56 INFO - [mozharness: 2017-09-01 22:48:56.313862Z] Finished read-buildbot-config step (success) 15:48:56 INFO - [mozharness: 2017-09-01 22:48:56.314078Z] Running download-and-extract step. 15:48:56 INFO - Running pre-action listener: _resource_record_pre_action 15:48:56 INFO - Running main action method: download_and_extract 15:48:56 INFO - mkdir: /builds/slave/test/build/tests 15:48: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:48:56 INFO - trying https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.test_packages.json 15:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:48:56 INFO - Downloaded 989 bytes. 15:48:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:48:56 INFO - Using the following test package requirements: 15:48:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:48:56 INFO - u'common': [u'target.common.tests.zip'], 15:48:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:48:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:48:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:48:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:48:56 INFO - u'mozbase': [u'target.common.tests.zip'], 15:48:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:48:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:48:56 INFO - u'web-platform': [u'target.common.tests.zip', 15:48:56 INFO - u'target.web-platform.tests.tar.gz'], 15:48:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:48:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:48:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip 15:48:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:56 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip into memory 15:48:58 INFO - Content-Length response header: 54957611 15:48:58 INFO - Bytes received: 54957611 15:49:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip 15:49:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:49:09 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.common.tests.zip into memory 15:49:10 INFO - Content-Length response header: 54957611 15:49:10 INFO - Bytes received: 54957611 15:49:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.talos.tests.zip 15:49:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:49:22 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.talos.tests.zip into memory 15:49:22 INFO - Content-Length response header: 14496650 15:49:22 INFO - Bytes received: 14496650 15:49:23 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:49:23 INFO - trying https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 15:49:23 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:49:24 INFO - Downloaded 62528630 bytes. 15:49:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 15:49:24 INFO - mkdir: /builds/slave/test/properties 15:49:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:24 INFO - Contents: 15:49:24 INFO - build_url:https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 15:49:24 INFO - Running post-action listener: _resource_record_post_action 15:49:24 INFO - Running post-action listener: find_tests_for_verification 15:49:24 INFO - Running post-action listener: set_extra_try_arguments 15:49:24 INFO - [mozharness: 2017-09-01 22:49:24.243984Z] Finished download-and-extract step (success) 15:49:24 INFO - [mozharness: 2017-09-01 22:49:24.244080Z] Running populate-webroot step. 15:49:24 INFO - Running pre-action listener: _resource_record_pre_action 15:49:24 INFO - Running main action method: populate_webroot 15:49:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:24 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:24 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:24 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'tests': ['damp', 'tps']}, 15:49:24 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['damp', 'tps']}, 15:49:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:49:24 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:49:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:49:24 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:49:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:24 INFO - 'ts_paint', 15:49:24 INFO - 'tpaint', 15:49:24 INFO - 'sessionrestore', 15:49:24 INFO - 'sessionrestore_many_windows', 15:49:24 INFO - 'sessionrestore_no_auto_restore', 15:49:24 INFO - 'tabpaint']}, 15:49:24 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['a11yr', 15:49:24 INFO - 'ts_paint', 15:49:24 INFO - 'tpaint', 15:49:24 INFO - 'sessionrestore', 15:49:24 INFO - 'sessionrestore_many_windows', 15:49:24 INFO - 'sessionrestore_no_auto_restore', 15:49:24 INFO - 'tabpaint']}, 15:49:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:49:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:49:24 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['bloom_basic_singleton']}, 15:49:24 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['bloom_basic']}, 15:49:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:24 INFO - 'tsvgr_opacity', 15:49:24 INFO - 'tart', 15:49:24 INFO - 'tscrollx', 15:49:24 INFO - 'tsvg_static']}, 15:49:24 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['tsvgx', 15:49:24 INFO - 'tsvgr_opacity', 15:49:24 INFO - 'tart', 15:49:24 INFO - 'tscrollx', 15:49:24 INFO - 'tsvg_static']}, 15:49:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:49:24 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo'], 15:49:24 INFO - 'tests': ['tp5o']}, 15:49:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:49:24 INFO - 'talos_options': ['--mitmproxy', 15:49:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:49:24 INFO - '--firstNonBlankPaint'], 15:49:24 INFO - 'tests': ['tp6_google', 15:49:24 INFO - 'tp6_youtube', 15:49:24 INFO - 'tp6_amazon', 15:49:24 INFO - 'tp6_facebook']}, 15:49:24 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo', 15:49:24 INFO - '--mitmproxy', 15:49:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:49:24 INFO - '--firstNonBlankPaint'], 15:49:24 INFO - 'tests': ['tp6_google', 15:49:24 INFO - 'tp6_youtube', 15:49:24 INFO - 'tp6_amazon', 15:49:24 INFO - 'tp6_facebook']}, 15:49:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo', 15:49:24 INFO - '--stylo-threads=1', 15:49:24 INFO - '--mitmproxy', 15:49:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:49:24 INFO - '--firstNonBlankPaint'], 15:49:24 INFO - 'tests': ['tp6_google', 15:49:24 INFO - 'tp6_youtube', 15:49:24 INFO - 'tp6_amazon', 15:49:24 INFO - 'tp6_facebook']}, 15:49:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--xperf_path', 15:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:24 INFO - 'tests': ['tp5n']}, 15:49:24 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:49:24 INFO - 'talos_options': ['--enable-stylo', 15:49:24 INFO - '--xperf_path', 15:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:24 INFO - 'tests': ['tp5n']}}} 15:49:24 INFO - Running post-action listener: _resource_record_post_action 15:49:24 INFO - [mozharness: 2017-09-01 22:49:24.258367Z] Finished populate-webroot step (success) 15:49:24 INFO - [mozharness: 2017-09-01 22:49:24.258457Z] Running create-virtualenv step. 15:49:24 INFO - Running pre-action listener: _resource_record_pre_action 15:49:24 INFO - Running main action method: create_virtualenv 15:49:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:49:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:49:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:49:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:25 INFO - Installing pip...............done. 15:49:25 INFO - Return code: 0 15:49:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:25 INFO - Reading from file tmpfile_stdout 15:49:25 INFO - Output received: 15:49:25 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:49:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:25 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:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:25 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:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:25 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:25 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:49:25 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:49:25 INFO - Using env: {'DISPLAY': ':0', 15:49:25 INFO - 'HOME': '/home/cltbld', 15:49:25 INFO - 'LANG': 'en_US.UTF-8', 15:49:25 INFO - 'LANGUAGE': 'en_US:en', 15:49:25 INFO - 'LOGNAME': 'cltbld', 15:49:25 INFO - 'MAIL': '/var/mail/cltbld', 15:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:25 INFO - 'MOZ_NO_REMOTE': '1', 15:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:25 INFO - 'NO_EM_RESTART': '1', 15:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:25 INFO - 'PWD': '/builds/slave/test', 15:49:25 INFO - 'SHELL': '/bin/bash', 15:49:25 INFO - 'SHLVL': '1', 15:49:25 INFO - 'TERM': 'linux', 15:49:25 INFO - 'TMOUT': '86400', 15:49:25 INFO - 'USER': 'cltbld', 15:49:25 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:25 INFO - '_': '/tools/buildbot/bin/python'} 15:49:26 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:49:26 INFO - Downloading/unpacking pip>=1.5 15:49:26 INFO - Running setup.py egg_info for package pip 15:49:26 INFO - warning: no files found matching 'pip/cacert.pem' 15:49:26 INFO - warning: no files found matching '*.html' under directory 'docs' 15:49:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:49:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:49:26 INFO - Installing collected packages: pip 15:49:26 INFO - Found existing installation: pip 1.1 15:49:26 INFO - Uninstalling pip: 15:49:26 INFO - Successfully uninstalled pip 15:49:26 INFO - Running setup.py install for pip 15:49:26 INFO - warning: no files found matching 'pip/cacert.pem' 15:49:26 INFO - warning: no files found matching '*.html' under directory 'docs' 15:49:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:49:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:49:26 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:49:26 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:49:26 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:49:26 INFO - Successfully installed pip 15:49:26 INFO - Cleaning up... 15:49:26 INFO - Return code: 0 15:49:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:26 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:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:26 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:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:26 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:26 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:49:26 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:49:26 INFO - Using env: {'DISPLAY': ':0', 15:49:26 INFO - 'HOME': '/home/cltbld', 15:49:26 INFO - 'LANG': 'en_US.UTF-8', 15:49:26 INFO - 'LANGUAGE': 'en_US:en', 15:49:26 INFO - 'LOGNAME': 'cltbld', 15:49:26 INFO - 'MAIL': '/var/mail/cltbld', 15:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:26 INFO - 'MOZ_NO_REMOTE': '1', 15:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:26 INFO - 'NO_EM_RESTART': '1', 15:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:26 INFO - 'PWD': '/builds/slave/test', 15:49:26 INFO - 'SHELL': '/bin/bash', 15:49:26 INFO - 'SHLVL': '1', 15:49:26 INFO - 'TERM': 'linux', 15:49:26 INFO - 'TMOUT': '86400', 15:49:26 INFO - 'USER': 'cltbld', 15:49:26 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:26 INFO - '_': '/tools/buildbot/bin/python'} 15:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:26 INFO - Downloading/unpacking psutil>=3.1.1 15:49:26 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:49:26 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:49:26 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:49:26 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:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:27 INFO - Installing collected packages: psutil 15:49:27 INFO - Running setup.py install for psutil 15:49:27 INFO - building 'psutil._psutil_linux' extension 15:49:27 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:49:28 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:49:28 INFO - building 'psutil._psutil_posix' extension 15:49:28 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:49:28 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:49:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:28 INFO - Successfully installed psutil 15:49:28 INFO - Cleaning up... 15:49:28 INFO - Return code: 0 15:49:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:28 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:28 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:49:28 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:49:28 INFO - Using env: {'DISPLAY': ':0', 15:49:28 INFO - 'HOME': '/home/cltbld', 15:49:28 INFO - 'LANG': 'en_US.UTF-8', 15:49:28 INFO - 'LANGUAGE': 'en_US:en', 15:49:28 INFO - 'LOGNAME': 'cltbld', 15:49:28 INFO - 'MAIL': '/var/mail/cltbld', 15:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:28 INFO - 'MOZ_NO_REMOTE': '1', 15:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:28 INFO - 'NO_EM_RESTART': '1', 15:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:28 INFO - 'PWD': '/builds/slave/test', 15:49:28 INFO - 'SHELL': '/bin/bash', 15:49:28 INFO - 'SHLVL': '1', 15:49:28 INFO - 'TERM': 'linux', 15:49:28 INFO - 'TMOUT': '86400', 15:49:28 INFO - 'USER': 'cltbld', 15:49:28 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:28 INFO - '_': '/tools/buildbot/bin/python'} 15:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:28 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:49:28 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:49:28 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:49:28 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:49:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:29 INFO - Installing collected packages: mozsystemmonitor 15:49:29 INFO - Running setup.py install for mozsystemmonitor 15:49:29 INFO - Successfully installed mozsystemmonitor 15:49:29 INFO - Cleaning up... 15:49:29 INFO - Return code: 0 15:49:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:29 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:29 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:49:29 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:49:29 INFO - Using env: {'DISPLAY': ':0', 15:49:29 INFO - 'HOME': '/home/cltbld', 15:49:29 INFO - 'LANG': 'en_US.UTF-8', 15:49:29 INFO - 'LANGUAGE': 'en_US:en', 15:49:29 INFO - 'LOGNAME': 'cltbld', 15:49:29 INFO - 'MAIL': '/var/mail/cltbld', 15:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:29 INFO - 'MOZ_NO_REMOTE': '1', 15:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:29 INFO - 'NO_EM_RESTART': '1', 15:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:29 INFO - 'PWD': '/builds/slave/test', 15:49:29 INFO - 'SHELL': '/bin/bash', 15:49:29 INFO - 'SHLVL': '1', 15:49:29 INFO - 'TERM': 'linux', 15:49:29 INFO - 'TMOUT': '86400', 15:49:29 INFO - 'USER': 'cltbld', 15:49:29 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:29 INFO - '_': '/tools/buildbot/bin/python'} 15:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:30 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:30 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:49:30 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:49:30 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:49:30 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:49:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:31 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:49:31 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:49:31 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:49:31 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:49:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:31 INFO - warning: no files found matching '*.txt' 15:49:31 INFO - no previously-included directories found matching 'build' 15:49:31 INFO - no previously-included directories found matching 'dist' 15:49:31 INFO - no previously-included directories found matching '.git*' 15:49:31 INFO - Installing collected packages: jsonschema, functools32 15:49:31 INFO - Running setup.py install for functools32 15:49:31 INFO - warning: no files found matching '*.txt' 15:49:31 INFO - no previously-included directories found matching 'build' 15:49:31 INFO - no previously-included directories found matching 'dist' 15:49:31 INFO - no previously-included directories found matching '.git*' 15:49:31 INFO - Successfully installed jsonschema functools32 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:31 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:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 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:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:31 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:49:31 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:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:31 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:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 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:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:31 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:49:31 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:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:32 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:49:32 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:49:32 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:49:32 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:49:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:33 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:49:33 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:49:33 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:49:33 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:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:33 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:49:33 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:49:33 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:49:33 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:49:33 INFO - Downloading docopt-0.6.1.tar.gz 15:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:33 INFO - Running setup.py install for blobuploader 15:49:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:33 INFO - Running setup.py install for requests 15:49:34 INFO - Running setup.py install for docopt 15:49:34 INFO - Successfully installed blobuploader requests docopt 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49: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:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49: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:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:34 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:49:34 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:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:34 INFO - Running setup.py (path:/tmp/pip-QEldOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:34 INFO - Running setup.py (path:/tmp/pip-qFIVSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:34 INFO - Running setup.py (path:/tmp/pip-RB3Npf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:34 INFO - Running setup.py (path:/tmp/pip-JFXV37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:34 INFO - Running setup.py (path:/tmp/pip-XIvQRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:34 INFO - Running setup.py (path:/tmp/pip-T2wIVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:34 INFO - Running setup.py (path:/tmp/pip-LqXm1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:34 INFO - Running setup.py (path:/tmp/pip-HOf_IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Running setup.py (path:/tmp/pip-a_dClf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Running setup.py (path:/tmp/pip-FYrVQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Running setup.py (path:/tmp/pip-zGzHxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Running setup.py (path:/tmp/pip-9TOKLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 INFO - Running setup.py (path:/tmp/pip-hKWCBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:35 INFO - Running setup.py (path:/tmp/pip-1IisSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:35 INFO - Running setup.py (path:/tmp/pip-kvWKoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:35 INFO - Running setup.py (path:/tmp/pip-4OGIY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:35 INFO - Running setup.py (path:/tmp/pip-8mPId4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:35 INFO - Running setup.py install for manifestparser 15:49:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:35 INFO - Running setup.py install for mozcrash 15:49:35 INFO - Running setup.py install for mozdebug 15:49:35 INFO - Running setup.py install for mozdevice 15:49:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozfile 15:49:36 INFO - Running setup.py install for mozhttpd 15:49:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozinfo 15:49:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozInstall 15:49:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozleak 15:49:36 INFO - Running setup.py install for mozlog 15:49:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for moznetwork 15:49:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:36 INFO - Running setup.py install for mozprocess 15:49:36 INFO - Running setup.py install for mozprofile 15:49:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozrunner 15:49:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozscreenshot 15:49:37 INFO - Running setup.py install for moztest 15:49:37 INFO - Running setup.py install for mozversion 15:49:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:37 INFO - Cleaning up... 15:49:37 INFO - Return code: 0 15:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:37 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:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:37 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:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:37 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:37 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:49:37 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:49:37 INFO - Using env: {'DISPLAY': ':0', 15:49:37 INFO - 'HOME': '/home/cltbld', 15:49:37 INFO - 'LANG': 'en_US.UTF-8', 15:49:37 INFO - 'LANGUAGE': 'en_US:en', 15:49:37 INFO - 'LOGNAME': 'cltbld', 15:49:37 INFO - 'MAIL': '/var/mail/cltbld', 15:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:37 INFO - 'MOZ_NO_REMOTE': '1', 15:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:37 INFO - 'NO_EM_RESTART': '1', 15:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:37 INFO - 'PWD': '/builds/slave/test', 15:49:37 INFO - 'SHELL': '/bin/bash', 15:49:37 INFO - 'SHLVL': '1', 15:49:37 INFO - 'TERM': 'linux', 15:49:37 INFO - 'TMOUT': '86400', 15:49:37 INFO - 'USER': 'cltbld', 15:49:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:37 INFO - '_': '/tools/buildbot/bin/python'} 15:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:37 INFO - Running setup.py (path:/tmp/pip-EsRCDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:37 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:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:37 INFO - Running setup.py (path:/tmp/pip-j9dS6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:37 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:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:37 INFO - Running setup.py (path:/tmp/pip-sgpjGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:37 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:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:37 INFO - Running setup.py (path:/tmp/pip-39LCAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:37 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:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:37 INFO - Running setup.py (path:/tmp/pip-TeA5Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 INFO - Running setup.py (path:/tmp/pip-VcKLcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 INFO - Running setup.py (path:/tmp/pip-4Q8A2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 INFO - Running setup.py (path:/tmp/pip-jP7Dp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:38 INFO - Running setup.py (path:/tmp/pip-LZGP49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:38 INFO - Running setup.py (path:/tmp/pip-CbcatY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:38 INFO - Running setup.py (path:/tmp/pip-Mc828n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:38 INFO - Running setup.py (path:/tmp/pip-31VllG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:38 INFO - Running setup.py (path:/tmp/pip-qsmV0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:38 INFO - Running setup.py (path:/tmp/pip-On0V3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:38 INFO - Running setup.py (path:/tmp/pip-h_rxHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:38 INFO - Running setup.py (path:/tmp/pip-eNcQv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:38 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:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:38 INFO - Running setup.py (path:/tmp/pip-VNuwUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:38 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:49:38 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:49:38 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:49:38 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:49:38 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:49:38 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:49:38 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:49:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:38 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:49:38 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:49:38 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:49:38 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:49:40 INFO - Downloading blessings-1.6.tar.gz 15:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:40 INFO - Installing collected packages: blessings 15:49:40 INFO - Running setup.py install for blessings 15:49:40 INFO - Successfully installed blessings 15:49:40 INFO - Cleaning up... 15:49:40 INFO - Return code: 0 15:49:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:40 INFO - Reading from file tmpfile_stdout 15:49:40 INFO - Current package versions: 15:49:40 INFO - argparse == 1.2.1 15:49:40 INFO - blessings == 1.6 15:49:40 INFO - blobuploader == 1.2.4 15:49:40 INFO - docopt == 0.6.1 15:49:40 INFO - functools32 == 3.2.3-2 15:49:40 INFO - jsonschema == 2.5.1 15:49:40 INFO - manifestparser == 1.1 15:49:40 INFO - mozInstall == 1.13 15:49:40 INFO - mozcrash == 1.0 15:49:40 INFO - mozdebug == 0.1 15:49:40 INFO - mozdevice == 0.51 15:49:40 INFO - mozfile == 1.2 15:49:40 INFO - mozhttpd == 0.7 15:49:40 INFO - mozinfo == 0.10 15:49:40 INFO - mozleak == 0.1 15:49:40 INFO - mozlog == 3.5 15:49:40 INFO - moznetwork == 0.27 15:49:40 INFO - mozprocess == 0.25 15:49:40 INFO - mozprofile == 0.28 15:49:40 INFO - mozrunner == 6.13 15:49:40 INFO - mozscreenshot == 0.1 15:49:40 INFO - mozsystemmonitor == 0.3 15:49:40 INFO - moztest == 0.8 15:49:40 INFO - mozversion == 1.4 15:49:40 INFO - psutil == 3.1.1 15:49:40 INFO - requests == 1.2.3 15:49:40 INFO - wsgiref == 0.1.2 15:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:40 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:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:40 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:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:40 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:40 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:49:40 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:49:40 INFO - Using env: {'DISPLAY': ':0', 15:49:40 INFO - 'HOME': '/home/cltbld', 15:49:40 INFO - 'LANG': 'en_US.UTF-8', 15:49:40 INFO - 'LANGUAGE': 'en_US:en', 15:49:40 INFO - 'LOGNAME': 'cltbld', 15:49:40 INFO - 'MAIL': '/var/mail/cltbld', 15:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:40 INFO - 'MOZ_NO_REMOTE': '1', 15:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:40 INFO - 'NO_EM_RESTART': '1', 15:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:40 INFO - 'PWD': '/builds/slave/test', 15:49:40 INFO - 'SHELL': '/bin/bash', 15:49:40 INFO - 'SHLVL': '1', 15:49:40 INFO - 'TERM': 'linux', 15:49:40 INFO - 'TMOUT': '86400', 15:49:40 INFO - 'USER': 'cltbld', 15:49:40 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:40 INFO - '_': '/tools/buildbot/bin/python'} 15:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:49:40 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:49:40 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:49:40 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:49:40 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:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:49:41 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:49:41 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:49:41 INFO - Installing collected packages: simplejson 15:49:41 INFO - Running setup.py install for simplejson 15:49:41 INFO - building 'simplejson._speedups' extension 15:49:41 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:49:42 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:49:42 INFO - Successfully installed simplejson 15:49:42 INFO - Cleaning up... 15:49:42 INFO - Return code: 0 15:49:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:42 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:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:42 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:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:42 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 0x232b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2697a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, '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': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', '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:49:42 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:49:42 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:49:42 INFO - Using env: {'DISPLAY': ':0', 15:49:42 INFO - 'HOME': '/home/cltbld', 15:49:42 INFO - 'LANG': 'en_US.UTF-8', 15:49:42 INFO - 'LANGUAGE': 'en_US:en', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MAIL': '/var/mail/cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SHLVL': '1', 15:49:42 INFO - 'TERM': 'linux', 15:49:42 INFO - 'TMOUT': '86400', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - '_': '/tools/buildbot/bin/python'} 15:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:43 INFO - Cleaning up... 15:49:43 INFO - Return code: 0 15:49:43 INFO - Running post-action listener: _resource_record_post_action 15:49:43 INFO - Running post-action listener: _start_resource_monitoring 15:49:43 INFO - Starting resource monitoring. 15:49:43 INFO - [mozharness: 2017-09-01 22:49:43.196155Z] Finished create-virtualenv step (success) 15:49:43 INFO - [mozharness: 2017-09-01 22:49:43.196620Z] Running install step. 15:49:43 INFO - Running pre-action listener: _resource_record_pre_action 15:49:43 INFO - Running main action method: install 15:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:43 INFO - Reading from file tmpfile_stdout 15:49:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:43 INFO - Reading from file tmpfile_stdout 15:49:43 INFO - Output received: 15:49:43 INFO - Usage: mozinstall [options] installer 15:49:43 INFO - Options: 15:49:43 INFO - -h, --help show this help message and exit 15:49:43 INFO - -d DEST, --destination=DEST 15:49:43 INFO - Directory to install application into. [default: 15:49:43 INFO - "/builds/slave/test"] 15:49:43 INFO - --app=APP Application being installed. [default: firefox] 15:49:43 INFO - mkdir: /builds/slave/test/build/application 15:49:43 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:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:50:00 INFO - Reading from file tmpfile_stdout 15:50:00 INFO - Output received: 15:50:00 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:00 INFO - Running post-action listener: _resource_record_post_action 15:50:00 INFO - [mozharness: 2017-09-01 22:50:00.019154Z] Finished install step (success) 15:50:00 INFO - [mozharness: 2017-09-01 22:50:00.019403Z] Running setup-mitmproxy step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running main action method: setup_mitmproxy 15:50:00 INFO - Skipping: mitmproxy is not required 15:50:00 INFO - Running post-action listener: _resource_record_post_action 15:50:00 INFO - [mozharness: 2017-09-01 22:50:00.020509Z] Finished setup-mitmproxy step (success) 15:50:00 INFO - [mozharness: 2017-09-01 22:50:00.020724Z] Running run-tests step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running pre-action listener: _set_gcov_prefix 15:50:00 INFO - Running main action method: run_tests 15:50:00 WARNING - Try message not found. 15:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:00 INFO - Python 2.7.3 15:50:00 INFO - Return code: 0 15:50:00 INFO - grabbing minidump binary from tooltool 15:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:00 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 0x269b090>, '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 0x269bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2695f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:00 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:50:00 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:50:00 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:50:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:00 INFO - Return code: 0 15:50:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:00 INFO - ENV: RUST_BACKTRACE is now full 15:50:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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:50:00 INFO - Using env: {'DISPLAY': ':0', 15:50:00 INFO - 'HOME': '/home/cltbld', 15:50:00 INFO - 'LANG': 'en_US.UTF-8', 15:50:00 INFO - 'LANGUAGE': 'en_US:en', 15:50:00 INFO - 'LOGNAME': 'cltbld', 15:50:00 INFO - 'MAIL': '/var/mail/cltbld', 15:50:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:00 INFO - 'MOZ_ACCELERATED': '1', 15:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:00 INFO - 'MOZ_NO_REMOTE': '1', 15:50:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:00 INFO - 'MOZ_WEBRENDER': '1', 15:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:00 INFO - 'NO_EM_RESTART': '1', 15:50:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:00 INFO - 'PWD': '/builds/slave/test', 15:50:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:00 INFO - 'RUST_BACKTRACE': 'full', 15:50:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:50:00 INFO - 'SHELL': '/bin/bash', 15:50:00 INFO - 'SHLVL': '1', 15:50:00 INFO - 'TERM': 'linux', 15:50:00 INFO - 'TMOUT': '86400', 15:50:00 INFO - 'USER': 'cltbld', 15:50:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:00 INFO - '_': '/tools/buildbot/bin/python'} 15:50:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:50:00 INFO - mozversion application_buildid: 20170901215936 15:50:00 INFO - mozversion application_changeset: 73e8f351b28ffc30e8077be21ce7298f4648ca5a 15:50:00 INFO - mozversion application_display_name: Nightly 15:50:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:00 INFO - mozversion application_name: Firefox 15:50:00 INFO - mozversion application_remotingname: firefox 15:50:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:50:00 INFO - mozversion application_vendor: Mozilla 15:50:00 INFO - mozversion application_version: 57.0a1 15:50:00 INFO - mozversion platform_buildid: 20170901215936 15:50:00 INFO - mozversion platform_changeset: 73e8f351b28ffc30e8077be21ce7298f4648ca5a 15:50:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:50:00 INFO - mozversion platform_version: 57.0a1 15:50:00 INFO - using testdate: 1504306200 15:50:00 INFO - actual date: 1504306200 15:50:00 INFO - starting webserver on 'localhost:38095' 15:50:00 INFO - SUITE-START | Running 2 tests 15:50:00 INFO - TEST-START | dromaeo_css 15:50:00 INFO - Initialising browser for dromaeo_css test... 15:50:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38095/getInfo.html -profile /tmp/tmpdJsUxx/profile 15:50:00 INFO - TEST-INFO | started process 15570 (/builds/slave/test/build/application/firefox/firefox http://localhost:38095/getInfo.html) 15:50:06 INFO - TEST-INFO | 15570: exit 0 15:50:06 INFO - Browser initialized. 15:50:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:06 INFO - Using env: {'DISPLAY': ':0', 15:50:06 INFO - 'HOME': '/home/cltbld', 15:50:06 INFO - 'JSGC_DISABLE_POISONING': '1', 15:50:06 INFO - 'LANG': 'en_US.UTF-8', 15:50:06 INFO - 'LANGUAGE': 'en_US:en', 15:50:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:50:06 INFO - 'LOGNAME': 'cltbld', 15:50:06 INFO - 'MAIL': '/var/mail/cltbld', 15:50:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:06 INFO - 'MOZ_ACCELERATED': '1', 15:50:06 INFO - 'MOZ_CRASHREPORTER': '1', 15:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:50:06 INFO - 'MOZ_NO_REMOTE': '1', 15:50:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:06 INFO - 'MOZ_WEBRENDER': '1', 15:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:06 INFO - 'NO_EM_RESTART': '1', 15:50:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:06 INFO - 'PWD': '/builds/slave/test', 15:50:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:06 INFO - 'RUST_BACKTRACE': 'full', 15:50:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:50:06 INFO - 'SHELL': '/bin/bash', 15:50:06 INFO - 'SHLVL': '1', 15:50:06 INFO - 'TERM': 'linux', 15:50:06 INFO - 'TMOUT': '86400', 15:50:06 INFO - 'USER': 'cltbld', 15:50:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 15:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:06 INFO - '_': '/tools/buildbot/bin/python'} 15:50:06 INFO - TEST-INFO | started process 15765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJsUxx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:07 INFO - PID 15765 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:50:07 INFO - PID 15765 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:50:08 INFO - PID 15765 | 15:50:08 INFO - PID 15765 | (/builds/slave/test/build/application/firefox/firefox:15827): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:50:08 INFO - PID 15765 | 15:50:18 INFO - PID 15765 | RSS: Main: 198889472 15:50:18 INFO - PID 15765 | 15:50:21 INFO - PID 15765 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:53:18 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38095/tests/dromaeo/cssquery-ext.html) 15:53:19 INFO - PID 15765 | RSS: Main: 212398080 15:53:19 INFO - PID 15765 | 15:56:21 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-ext.html (next: http://localhost:38095/tests/dromaeo/cssquery-jquery.html) 15:56:22 INFO - PID 15765 | RSS: Main: 209342464 15:56:22 INFO - PID 15765 | 15:59:24 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38095/tests/dromaeo/cssquery-mootools.html) 15:59:24 INFO - PID 15765 | RSS: Main: 211574784 15:59:24 INFO - PID 15765 | 16:02:26 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38095/tests/dromaeo/cssquery-prototype.html) 16:02:27 INFO - PID 15765 | RSS: Main: 210194432 16:02:27 INFO - PID 15765 | 16:05:31 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38095/tests/dromaeo/cssquery-yui.html) 16:05:32 INFO - PID 15765 | RSS: Main: 216035328 16:05:32 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | Cycle 1(1): loaded http://localhost:38095/tests/dromaeo/cssquery-yui.html (next: http://localhost:38095/tests/dromaeo/cssquery-dojo.html) 16:08:34 INFO - PID 15765 | RSS: Main: 214159360 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | __start_tp_report 16:08:34 INFO - PID 15765 | _x_x_mozilla_page_load 16:08:34 INFO - PID 15765 | _x_x_mozilla_page_load_details 16:08:34 INFO - PID 15765 | |i|pagename|runs| 16:08:34 INFO - PID 15765 | |0;dojo.html;3255.6744325567447;3265.8530366133523;3271.1822044488877;3286.293446908914;3290.161008942719;6314.116023756666;6314.589551679143;6397.456216221621;6398.232212134544;6519.478441724663;6455.935440645592;6506.707198176082;6564.606123632585;6568.441682456997;6608.801735947929;5820.185174075633;5904.321003084636;5914.260717410324;5927.703614819242;5955.702214889249;5895.4399332063385;5905.881882362351;6019.3980601939675;6024.909626355608;6028;5885.440883116097;5916.319623243339;6012.579119461661;6016.127661489081;6016.27804663441;5903.173555702205;5942.316633587149;5949.524038076944;5992.49063829575;6037.094435834616;5770.8268751937085;5817.825465236049;5871.031279838864;5934;5950.5834591578605;6367.999999999954;6408.67956602168;6423.582467139668;6471.320511346288;6477.578957367803;6895.965520172417;6908;6992.825179370506;7004.334588214111;7007.229204787469;6962.65186740666;6964.79105626832;6965.825854353631;7051.506394552383;7067.399271061966;6297.905531417033;6422.165118534561;6434.420902118832;6465.062565927914;6552;7044.295570443017;7135.7859264221115;7139.214686384494;7203.351698347174;7217.097862767154;6744.494162937799;6812.829679258059;6850.040994260808;6902.758403455855;6913.170419549686;6907.827304317432;6915.031895534629;6974.79075627732;7002.964985175042;7016.684249208798;6700.296468870796;6854.725810967506;6871.415929646036;6958.617276049765;6960.79117626472;6793.762218322335;6858.3141685831015;6896.172459304815;6903.482238832108;6905;5415.079436495806;5471.917921231185;5484.177373394023;5487.067198576172;5491.313585801775;4772.49888761682;4845.9030819383415;4851.684640498356;4852.80588776445;4879.926801097987;6025.548083893726;6035.30593981689;6108.961476548998;6127.601705889103;6129;6739.59562426256;6933.5493192942295;6955.1653801543125;6965.965170174117;7032.367086962198;5902.498287645598;5953.761849526057;6009.429104235091;6015;6060.666663333471;5921.763129474859;5940.70296485174;5949.345571987078;5999.790007349722;6008.188894499274;6662.633555154416;6751.831204219934;6757.391834734897;6776.728930842711;6784.626845523445;6734.292899245705;6927.89608155868;6928;7003.54476958996;7006.404455621329;6564.212294524687;6602.60384376939;6608.570442921195;6619.569727967667;6622.337766223532;6624.403803657694;6699.799006029827;6708.597484150967;6719.966400167968;6728.226253980855;6846.828829279308;6858.862822743417;6862.965685171542;6868.038474613458;6870.931290687229;5691.345495267931;6566.343365663395;6611.438027767694;6714;6797.694103765243;6714.764983225564;6753.831154221184;6760.290169532128;6820.079289295882;6852.931470685229;6484.70818813164;6610.8016759497295;6629.303923088007;6645.335466453316;6750.8649827004165;6666.966665166643;6795.932040679728;6798.354156355138;6850.314968503109;6893.517453778388;6431.871362572629;6527.412532871875;6538.574992625464;6594.10979517759;6625.105610742488 16:08:34 INFO - PID 15765 | |1;ext.html;812.3257696112228;818.1205204405262;847.195164593636;864.1099667342639;872.5201139373345;39173;39735.60264397355;39844.60155398445;40081.19837603246;40300.59699403005;37137.628623713754;37365;37453.625463745426;37462.43806342907;37499.250014999685;6877.8624427511295;6885.758998435056;6894.517383783137;6948.617826019567;6962.791116266495;6894.655267236643;6897.241303456641;6939.37545620894;6980.37176654101;6988.790336289894;6956.513044086916;7624.466287359859;7719.266669666373;7745.883811742829;7800.609969501531;7659.961700191491;7707.96146019272;7712.845743085163;7714.459987800856;7720.150783413848;7444.925550744478;7582.810429739246;7659.387249020065;7666.578338191397;7674.42441816866;37096.258074838355;37267;37516.624833751855;37579.81210093959;37583.62416375856;3551.627079156703;3591.892243232707;3598.3702852000797;3601.603823579404;3605.9098522537147;30766.53850192249;30827;30956.380872382426;31029.37941241185;31047.534286985712;5135.512126347991;5191.532762051434;5193.272941788115;5241.68549887008;5293.39126000511;182667.08666456715;183341;185060;185157;185444;46904.29643555349;47442;47492;47521.28718069162;47571.28643070357;49707.50292497101;49776.25335619968;49825.50174498281;50015.24977125346;50045.49954500408;13859.376328065262;14122.646933826736;14177;14202.360893759806;14208.573742787732;11265.436728163559;11337.886621133848;11397.658070257905;11399.430028498708;11401.315921044765;13759.17444953286;13866.376013079436;14012.929935350461;14115.50595729165;14132.646683832987;5634.32388113429;5727.083666613322;5758.942410575924;5784.132380142928;5821.15593238978;999.9550020249106;1007.2697294461603;1014.4572653630272;1017.4048181813722;1028.6348346337093;22385.44036399103;22583.54832903333;22708.318750437513;22728.20451284197;22818;1094.7099018760034;1104.5857803323754;1107.7950579142885;1111.716512289361;1130.6268931252666;11971.475545827545;12065.638030859089;12120.333381664093;12182.329971851634;12235.97306188867;217071;217109;218170;219574;221022;43776;50190.74904625527;50285.24572131421;51127.23309150366;51208.23187652114;1424.1099312929418;1441.5315022617692;1444.6316189371853;1450.376338174595;1451.4702133721328;26325.473490529697;26360.20919372422;26537.60193597059;27096.458070838868;27151;35844;36151.27697445984;36215.81892090523;36375.63624363722;36398;191272;191746;192135;193485;193490;33314;33339.66660333366;33417.33165336631;33614.83192584021;33618;40423.1915361697;41471.37792933169;41816.790916045225;41937.16125677408;41958.790206048776;31284.530732038584;31303.530447042856;31742.841285793424;32111;32341.676583233868;29817.25456863596;31072.378552429276;31339.843300783352;31592.842035789676;31638.841805790824;35576.110597235274;35582.46626300556;35755.821220893726;35802;35837.46243806397;30911.536326955564;30922.536161957138;31227.53158702576;31616.367672646877;31633.20916977002;22264.685632178534;22989.770102298764;23151.189708360125;23186.188483403;23279.650805237598 16:08:34 INFO - PID 15765 | |2;jquery.html;567.1889198446223;568.074039315915;569.0269638917454;582.2111039541421;590.4243362721346;22428.88785556072;22947.196848110318;22957.08171673131;22966.196183133572;22982;23642;24734.62898056526;25963;26136.215913522577;26213.213603591874;6742.696578653972;6870;6888.207856096538;6906;6934.4452443804375;6808.59148451092;6849.691763870613;6850.588964662112;6862.828429289258;6882.346177113166;4172;4173.373993900924;5043.924341134886;6583.242927063401;6825.761098361559;6502.5448218624715;6525.1517302750335;6550.836229094263;6554.14796076507;6554.9344506555035;6058.697065146725;6075.787347442818;6088.4215999479975;6092.5430592705725;6125.418085281935;27906.720932790617;28665.426691466262;29114.41771164586;29133;29143.271418214714;1943.6695761720541;1976.3379267945256;1978.9802101979085;1979.604079184169;1980.8712433691908;19614.41156765285;20120.49698757543;20223.08996095179;20230.595388092155;20257.594848102955;2367.8342516023886;2412.770786775271;2417.613181890889;2419.0444774314224;2461.2247142150163;125855;126234;126868;127709;128334.35832820776;13957.511487097903;14391.208483533506;14428;14797.704045919021;14813.777793333109;22207.1117155312;22373.440663983532;22375.44061398478;22443.43891402728;22665.320040398816;9671.419714817133;9855.90144098564;9918.80162396748;9958.55186516594;10045.648402306031;9012.63949442028;9059.275257979345;9141.3601047926;9143.039980802054;9182.449053056838;8836.558172091498;8841.16008979146;9235.722928312027;9482.780162827476;9557.378770379903;2685.4763321152186;2747.4779791839487;2760.2271364018106;2771.9584206236923;2790;952.8046750416148;956.4309236004566;962.9614815407306;977.5894124467599;985.7831277119022;18791.50365007282;18905.81094189068;19128.61742765137;19201.32795352156;19616.411507654793;1015.761296095417;1050.2543194332109;1055.5250137438184;1056.5404049238605;1061.5117046158853;10484.161267098614;10633.255672102878;10634.255602107778;10710;10842.024217820433;490882;492988;497890;499323;503385;118159.40920295515;118938;120160.39919800345;123238.38380808038;128066;1231.199720181889;1246.5512415530402;1247.6880779804867;1279.0279387665441;1287.1826390242263;20261.6960745586;20692.793072069086;21413.46466338354;21599.676004859626;21630.89184554067;58101.418985811295;59391;60587;61226.69386653038;61490;72008;72044.63977680077;73202.26797732168;75073.62463187867;76520.23479765131;19397.2241110354;20073.29743458972;20073.297434590302;20127.899360503103;20467.69298460554;22677.092916283164;22760;23297;23379;23390.064397424594;19121.71317430212;19498.22007119756;19503.60992780108;19525.70711439301;19674.90162549178;16901.239444225284;17007.14964251807;17406.39077632277;17617.119144042492;17879.553011174303;19909.800901991373;20006.199752009758;20038.49903752418;20106.698399523728;20280.087396066916;19421.126049327533;20006;20250.59498809986;20293.797062029782;20689.27587534429;17643;18066.81933180704;18141.45575632733;18166.455006349832;18244.817551824843 16:08:34 INFO - PID 15765 | |3;mootools.html;1316.2168509736707;1328.9269090200034;1349.439982407301;1355.7017456159642;1366.057420379938;14427.206503642296;15030.398784048639;15071.62320941977;15160.696786064273;15354.69290614187;15713.214339283048;15839.762403563927;16034.518964431056;16048.197590120506;16088.919555402235;2775.528160212764;2801.29967508123;2807.705190954951;2809.9157025289273;2812.606235127084;2659.2687011071916;2724.7956403269736;2819.126070918012;2820.083472871315;2829.038127036807;2791.148699646607;2801.229661842989;2871.181713211735;2871.325238568945;2875.151830210093;2687.731226877316;2688.07261494784;2719.6600424946882;2739.1919383781833;2745.8627068646488;2732.1120635793445;2758.724127587245;2767.5848622706753;2786.5959435881887;2789.4839454700946;14927.552173434815;15218.163001034938;15275;15288.388464461408;15299.464518741903;8047.114817370085;8361.372897032747;8363.916360836436;8374.581270936429;8375.41372103947;5461.590380721462;5511.949562582458;5580.218769372291;5600.327960644708;5729.627574207663;1896.2035944903037;1917.9136938837646;1939.3115444017312;1962.931297404584;1969.5962327722782;26728.331791705168;26894.5965810513;26947.86526067357;27009;27019.459610807673;6637.46900247979;6736.157980252468;6787.136112714387;6878.896816547755;6957.582545047313;16228;16302;16304.51086467408;16309.755353669705;16330.428435004718;7719.150893401721;7908.644111015018;7917.802054948673;7918.406119541058;7929.04851417822;7193.604351760599;7223.2415596361625;7306.561606303639;7322.267773222635;7362.226966168475;4683.859484215479;4982.202847544376;5100.2349647553165;5111.080005598954;5113.437521872591;1335.8463776665808;1505.8795296376263;1515.1515151514966;1525.3745964154643;1544.783730277762;859.1623167411849;888.6445421831319;890.3322508118911;891.8394688955921;896.8744375787395;7183.245759195313;7188.137423509213;7225.927740722525;7273.127224733066;7283.70865165398;947.1381043250609;958.1424624960761;961.6778379242892;965.0928127560071;966.4826222830089;4262.339337402707;4431.113777244564;4437.866863994085;4444.911101777946;4466.59800617946;21239.78760212409;21379;21632.459188520414;21791.782082179292;21921;21158.47103822417;21253.17442860269;21640;21844.78155218459;21933;10618.840717389245;10623;10678.733031674115;10741.570337186426;10817.783644327226;7654.250725136888;7771;7874.881876771968;7905.960470197612;7930.801729956797;18073.548161296072;18737.718934215725;18745.531361716065;19016.144273508;19029.71455428142;19120.713189301892;19140.138693758538;19458.8054119457;19497.902510487358;19677.704834427783;10872.61945831892;10938.234323597271;10942.726431839268;10949.83575246356;11061.391623460466;13987.510437134652;14421.78367324512;14494.565163045125;14567.708645826811;14584.124952502883;11499.597514086967;11638.6508404748;11843.822342664695;11860.288382697066;12032.037437005194;11147.609833655782;11347.659570212907;11453.083753299883;11477.311361318347;11484.368359740294;9031.50326732036;9066.773330666521;9102.271818254392;9103.954480227556;9114.954425227832;6792.354726300993;6974.965125174342;6986.685599147949;7016.7544135954995;7104.538205016657;6850.246472887879;6912.896306555506;7019.6490175492045;7025.332593403618;7080.291970803085 16:08:34 INFO - PID 15765 | |4;prototype.html;497.527289371822;503.1158312121105;523.8926020165865;527.4593541619837;527.7071225469863;6471.546991710582;6487.41613254807;6502.821554779154;6530.510211734121;6531.673416329182;6151.846203844906;6210.19267495225;6273.874522509547;6319.936800631992;6355.205599300088;4971.179755340382;5063.215201643751;5102.821401250957;5104.923426148611;5136.948630513703;4871.585915197213;5126.384833819928;5133.435322114583;5161.793528258865;5180.715060671661;4938.308636790852;5007.624428167884;5058.620603454738;5075.543201111899;5117.257997590347;5007.899842003176;5009.499050094998;5014.799408023693;5084.957583695334;5087.186050231963;4531.207038768202;4537;4547.47704014036;4580.221362368406;4605.700629459108;6225.968870155665;6228.937710622881;6259.561830671855;6271.498280137624;6274.937250627481;5783.942160578383;5790.189373487715;5842.18209450673;5853.268341457318;5884.499817515516;6578.5395022347975;6593.637349945751;6595.901061484082;6607;6684.2981486944145;4907.730074845882;4947.282644016597;4949.109160351135;4953.628477864138;4960;7003.54476958996;7095.929040709579;7106.893396599055;7134.607596582134;7135.714571417137;5009.799608015712;5057.266696329012;5101.948980510221;5116.181410974301;5123.692578445305;5027.120253955543;5043.89034412436;5049.671771334852;5058.620603454756;5105.795768169231;5687.829365119053;5693.629914055573;5785.132230165509;5808.099744539603;5814.505767009767;6614.768483103068;6723.394894459424;6792;6802.727890884309;6842.863142737217;1684.5788552861784;1685.5954570902895;1714.2800023989955;1752.815954324803;1757.7275522294065;1183.1126655008743;1219.4634360881184;1234.9320787356603;1237.5297386992886;1244.9439775209955;5843.159404787479;5854.619449735754;5861.856937897154;5880.500157486576;5952.464278214981;6674.766383176566;6706.530542861953;6752.493562982796;6753.602471122681;6763.6618169092335;5764.74058667361;5772.7113644317615;5847.44449277318;5850.736716847752;5893.646381217055;3472.6353732858192;3580.230250496156;3609.3322735294055;3622.927541449209;3629.510016147839;6557.901631475532;6559.868802623921;6560.44236239925;6635.303293154246;6685.061332213701;7053.964730176419;7054.894176587355;7067.22260551339;7077.292270772985;7104.92895071053;6534.607923524603;6566.868662626816;6620.768273110418;6624.138861947916;6659.2008958925235;6674.292336202086;6696.866062678621;6777.89833152513;6824.385805277549;6854.485913556404;6696.526764111888;6746.224184218878;6778.102131403215;6783.253842077466;6893;6646.567973081735;6651.33486651331;6682;6738.932610674026;6738.9554619034125;5070.6957582545165;5079.593632509316;5080.517350851663;5099.87250318745;5106.208537676666;6678.265390807104;6817.5568588041615;6865.828354290983;6889.517733758589;6890.586564806128;6554.770583029571;6583.407493325432;6619.470442364503;6656.267810540933;6672.4328432081875;6561.507886908405;6607.7710265429205;6652.534322597372;6654.866902661823;6665.366790154928;6490.156279683611;6575.342465753386;6604.570702904296;6609.272979972296;6615.900761488678;6552.63960482159;6554.934450655433;6613.735450581923;6616.152282387706;6678.297034256234;6193.690315484298;6258.499320054294;6391.456726178327;6395.808125756234;6497.426415471377 16:08:34 INFO - PID 15765 | |5;yui.html;900.3157600223828;901.3555307954813;915.0483497162951;916.6012784438769;923.3029063057388;18308.45074647761;19153.329633462832;19237.23051077955;19252.326168584103;19256.90371548142;19259.614807703838;19280.132394042266;19457;19497.220111195536;19540.70688939667;980.7989362180735;986.058314309836;1001.5743309093642;1004.8593196952432;1007.028217769852;893.1916615462984;983.822911875862;994.7662299359681;1011.3375738891039;1012.084063922148;1049.2917280835443;1049.7847941172042;1050.7793363393696;1052.5211028981794;1054.5781687325054;1024.6516184497307;1052.763128296131;1054.6941386997762;1055.9472026398687;1056.2922841696006;769.0655853138408;769.2922511289571;770.2720928722359;776.3362325211918;777.1645481107776;19115.71326430105;19978.400647980583;20086.296979605642;20173;20197;20810.47973800667;21244.681329780065;21412.57174856494;21474.141034358607;21705.565888682137;16107.436239731553;16724.163791810362;16885.324587016505;16902.74645880313;17011.829881701273;3692.8522859085606;3702.500162478058;3716.2567486502808;3730.850765969385;3740.4576336431337;124997;125912;129912.35043824815;130472;130527;16185.676286474205;16346.50960471164;16743;16751.32994680199;16924.746128808078;28971.42057158845;29031.12906612805;29614.259643508653;29660.555091673643;30197;8966.68616598416;9058.864117038249;9126.45241285525;9135.588898499584;9166.358354915224;4041.7574945503366;4054.5945405459806;4107.158032603309;4118.588141185917;4159.688023398257;5224.242484839677;5228.398734145546;5261.105612045962;5265.447128051499;5287.867803304871;1012.5645972231864;1034.8344264917578;1036.9637062702768;1039.1738567838586;1047.1047254597363;677.2279601254573;681.1077488489994;708.5217478202296;710.3784188834769;716.0583832260561;10964.945175274073;11204.887951120547;11257.380844053656;11740.354280514654;12551.3096779678;685.5030103175158;685.6811582614108;689.1867596236389;695.58265040975;700.0898831519005;5167.689938603696;5218.217267409919;5319.255304257407;5782.624129431573;5807;104995.47502262439;105281;105949.47025264824;109537.8063045504;111359;90588;94032;95943;95956;97889.51055244678;79236;82572.17427825645;82887;83999;84788;11956.70108247266;12278.283796740187;12291.201071930296;12344.81482777741;12410.875891240972;38126;38364;38576.42135368028;39776.20447590974;40874.59125408708;51250.74374628103;51742.223866641274;52141.47858521366;52790.47209528009;53165.468345316054;17719.91140044343;17992.730109048112;18003.909980450015;18026.098695065455;18088.366907158186;18454.538636533656;18542.44372668822;18658.72011919795;18726.063696815378;18892.244310227437;16594.419195328104;16749.497515074567;16852;16905.91547042257;17163.656726865644;16638.750418743486;16667.74998375001;16758.58103547421;16765.580860478585;17124.229409676343;15909.681806363576;16088.597785055466;16236.594085147493;16377.42679006229;16740.49778506647;11435.428228588704;11446.828297575377;11673.182877198855;11735.589254376056;11752.11859110553;11549.595764148215;11790.882091178979;11805.291682499077;11965.461554230254;12148.635540933787 16:08:34 INFO - PID 15765 | __end_tp_report 16:08:34 INFO - PID 15765 | __start_cc_report 16:08:34 INFO - PID 15765 | _x_x_mozilla_cycle_collect,372 16:08:34 INFO - PID 15765 | __end_cc_report 16:08:34 INFO - PID 15765 | __startTimestamp1504307314585__endTimestamp 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | ------- Summary: start ------- 16:08:34 INFO - PID 15765 | Number of tests: 6 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#0] dojo.html Cycles:165 Average:6355.67 Median:6602.60 stddev:749.49 (11.4%) stddev-sans-first:711.24 16:08:34 INFO - PID 15765 | Values: 3255.7 3265.9 3271.2 3286.3 3290.2 6314.1 6314.6 6397.5 6398.2 6519.5 6455.9 6506.7 6564.6 6568.4 6608.8 5820.2 5904.3 5914.3 5927.7 5955.7 5895.4 5905.9 6019.4 6024.9 6028.0 5885.4 5916.3 6012.6 6016.1 6016.3 5903.2 5942.3 5949.5 5992.5 6037.1 5770.8 5817.8 5871.0 5934.0 5950.6 6368.0 6408.7 6423.6 6471.3 6477.6 6896.0 6908.0 6992.8 7004.3 7007.2 6962.7 6964.8 6965.8 7051.5 7067.4 6297.9 6422.2 6434.4 6465.1 6552.0 7044.3 7135.8 7139.2 7203.4 7217.1 6744.5 6812.8 6850.0 6902.8 6913.2 6907.8 6915.0 6974.8 7003.0 7016.7 6700.3 6854.7 6871.4 6958.6 6960.8 6793.8 6858.3 6896.2 6903.5 6905.0 5415.1 5471.9 5484.2 5487.1 5491.3 4772.5 4845.9 4851.7 4852.8 4879.9 6025.5 6035.3 6109.0 6127.6 6129.0 6739.6 6933.5 6955.2 6966.0 7032.4 5902.5 5953.8 6009.4 6015.0 6060.7 5921.8 5940.7 5949.3 5999.8 6008.2 6662.6 6751.8 6757.4 6776.7 6784.6 6734.3 6927.9 6928.0 7003.5 7006.4 6564.2 6602.6 6608.6 6619.6 6622.3 6624.4 6699.8 6708.6 6720.0 6728.2 6846.8 6858.9 6863.0 6868.0 6870.9 5691.3 6566.3 6611.4 6714.0 6797.7 6714.8 6753.8 6760.3 6820.1 6852.9 6484.7 6610.8 6629.3 6645.3 6750.9 6667.0 6795.9 6798.4 6850.3 6893.5 6431.9 6527.4 6538.6 6594.1 6625.1 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#1] ext.html Cycles:180 Average:36334.41 Median:35579.29 stddev:51495.37 (144.7%) stddev-sans-first:51570.75 16:08:34 INFO - PID 15765 | Values: 812.3 818.1 847.2 864.1 872.5 39173.0 39735.6 39844.6 40081.2 40300.6 37137.6 37365.0 37453.6 37462.4 37499.3 6877.9 6885.8 6894.5 6948.6 6962.8 6894.7 6897.2 6939.4 6980.4 6988.8 6956.5 7624.5 7719.3 7745.9 7800.6 7660.0 7708.0 7712.8 7714.5 7720.2 7444.9 7582.8 7659.4 7666.6 7674.4 37096.3 37267.0 37516.6 37579.8 37583.6 3551.6 3591.9 3598.4 3601.6 3605.9 30766.5 30827.0 30956.4 31029.4 31047.5 5135.5 5191.5 5193.3 5241.7 5293.4 182667.1 183341.0 185060.0 185157.0 185444.0 46904.3 47442.0 47492.0 47521.3 47571.3 49707.5 49776.3 49825.5 50015.2 50045.5 13859.4 14122.6 14177.0 14202.4 14208.6 11265.4 11337.9 11397.7 11399.4 11401.3 13759.2 13866.4 14012.9 14115.5 14132.6 5634.3 5727.1 5758.9 5784.1 5821.2 1000.0 1007.3 1014.5 1017.4 1028.6 22385.4 22583.5 22708.3 22728.2 22818.0 1094.7 1104.6 1107.8 1111.7 1130.6 11971.5 12065.6 12120.3 12182.3 12236.0 217071.0 217109.0 218170.0 219574.0 221022.0 43776.0 50190.7 50285.2 51127.2 51208.2 1424.1 1441.5 1444.6 1450.4 1451.5 26325.5 26360.2 26537.6 27096.5 27151.0 35844.0 36151.3 36215.8 36375.6 36398.0 191272.0 191746.0 192135.0 193485.0 193490.0 33314.0 33339.7 33417.3 33614.8 33618.0 40423.2 41471.4 41816.8 41937.2 41958.8 31284.5 31303.5 31742.8 32111.0 32341.7 29817.3 31072.4 31339.8 31592.8 31638.8 35576.1 35582.5 35755.8 35802.0 35837.5 30911.5 30922.5 31227.5 31616.4 31633.2 22264.7 22989.8 23151.2 23186.2 23279.7 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#2] jquery.html Cycles:180 Average:35374.99 Median:22961.64 stddev:83427.38 (363.3%) stddev-sans-first:83620.48 16:08:34 INFO - PID 15765 | Values: 567.2 568.1 569.0 582.2 590.4 22428.9 22947.2 22957.1 22966.2 22982.0 23642.0 24734.6 25963.0 26136.2 26213.2 6742.7 6870.0 6888.2 6906.0 6934.4 6808.6 6849.7 6850.6 6862.8 6882.3 4172.0 4173.4 5043.9 6583.2 6825.8 6502.5 6525.2 6550.8 6554.1 6554.9 6058.7 6075.8 6088.4 6092.5 6125.4 27906.7 28665.4 29114.4 29133.0 29143.3 1943.7 1976.3 1979.0 1979.6 1980.9 19614.4 20120.5 20223.1 20230.6 20257.6 2367.8 2412.8 2417.6 2419.0 2461.2 125855.0 126234.0 126868.0 127709.0 128334.4 13957.5 14391.2 14428.0 14797.7 14813.8 22207.1 22373.4 22375.4 22443.4 22665.3 9671.4 9855.9 9918.8 9958.6 10045.6 9012.6 9059.3 9141.4 9143.0 9182.4 8836.6 8841.2 9235.7 9482.8 9557.4 2685.5 2747.5 2760.2 2772.0 2790.0 952.8 956.4 963.0 977.6 985.8 18791.5 18905.8 19128.6 19201.3 19616.4 1015.8 1050.3 1055.5 1056.5 1061.5 10484.2 10633.3 10634.3 10710.0 10842.0 490882.0 492988.0 497890.0 499323.0 503385.0 118159.4 118938.0 120160.4 123238.4 128066.0 1231.2 1246.6 1247.7 1279.0 1287.2 20261.7 20692.8 21413.5 21599.7 21630.9 58101.4 59391.0 60587.0 61226.7 61490.0 72008.0 72044.6 73202.3 75073.6 76520.2 19397.2 20073.3 20073.3 20127.9 20467.7 22677.1 22760.0 23297.0 23379.0 23390.1 19121.7 19498.2 19503.6 19525.7 19674.9 16901.2 17007.1 17406.4 17617.1 17879.6 19909.8 20006.2 20038.5 20106.7 20280.1 19421.1 20006.0 20250.6 20293.8 20689.3 17643.0 18066.8 18141.5 18166.5 18244.8 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#3] mootools.html Cycles:180 Average:9269.33 Median:2735.65 stddev:6733.74 (246.1%) stddev-sans-first:6726.12 16:08:34 INFO - PID 15765 | Values: 1316.2 1328.9 1349.4 1355.7 1366.1 14427.2 15030.4 15071.6 15160.7 15354.7 15713.2 15839.8 16034.5 16048.2 16088.9 2775.5 2801.3 2807.7 2809.9 2812.6 2659.3 2724.8 2819.1 2820.1 2829.0 2791.1 2801.2 2871.2 2871.3 2875.2 2687.7 2688.1 2719.7 2739.2 2745.9 2732.1 2758.7 2767.6 2786.6 2789.5 14927.6 15218.2 15275.0 15288.4 15299.5 8047.1 8361.4 8363.9 8374.6 8375.4 5461.6 5511.9 5580.2 5600.3 5729.6 1896.2 1917.9 1939.3 1962.9 1969.6 26728.3 26894.6 26947.9 27009.0 27019.5 6637.5 6736.2 6787.1 6878.9 6957.6 16228.0 16302.0 16304.5 16309.8 16330.4 7719.2 7908.6 7917.8 7918.4 7929.0 7193.6 7223.2 7306.6 7322.3 7362.2 4683.9 4982.2 5100.2 5111.1 5113.4 1335.8 1505.9 1515.2 1525.4 1544.8 859.2 888.6 890.3 891.8 896.9 7183.2 7188.1 7225.9 7273.1 7283.7 947.1 958.1 961.7 965.1 966.5 4262.3 4431.1 4437.9 4444.9 4466.6 21239.8 21379.0 21632.5 21791.8 21921.0 21158.5 21253.2 21640.0 21844.8 21933.0 10618.8 10623.0 10678.7 10741.6 10817.8 7654.3 7771.0 7874.9 7906.0 7930.8 18073.5 18737.7 18745.5 19016.1 19029.7 19120.7 19140.1 19458.8 19497.9 19677.7 10872.6 10938.2 10942.7 10949.8 11061.4 13987.5 14421.8 14494.6 14567.7 14584.1 11499.6 11638.7 11843.8 11860.3 12032.0 11147.6 11347.7 11453.1 11477.3 11484.4 9031.5 9066.8 9102.3 9104.0 9115.0 6792.4 6975.0 6986.7 7016.8 7104.5 6850.2 6912.9 7019.6 7025.3 7080.3 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#4] prototype.html Cycles:180 Average:5601.12 Median:6259.03 stddev:1583.03 (25.3%) stddev-sans-first:1540.43 16:08:34 INFO - PID 15765 | Values: 497.5 503.1 523.9 527.5 527.7 6471.5 6487.4 6502.8 6530.5 6531.7 6151.8 6210.2 6273.9 6319.9 6355.2 4971.2 5063.2 5102.8 5104.9 5136.9 4871.6 5126.4 5133.4 5161.8 5180.7 4938.3 5007.6 5058.6 5075.5 5117.3 5007.9 5009.5 5014.8 5085.0 5087.2 4531.2 4537.0 4547.5 4580.2 4605.7 6226.0 6228.9 6259.6 6271.5 6274.9 5783.9 5790.2 5842.2 5853.3 5884.5 6578.5 6593.6 6595.9 6607.0 6684.3 4907.7 4947.3 4949.1 4953.6 4960.0 7003.5 7095.9 7106.9 7134.6 7135.7 5009.8 5057.3 5101.9 5116.2 5123.7 5027.1 5043.9 5049.7 5058.6 5105.8 5687.8 5693.6 5785.1 5808.1 5814.5 6614.8 6723.4 6792.0 6802.7 6842.9 1684.6 1685.6 1714.3 1752.8 1757.7 1183.1 1219.5 1234.9 1237.5 1244.9 5843.2 5854.6 5861.9 5880.5 5952.5 6674.8 6706.5 6752.5 6753.6 6763.7 5764.7 5772.7 5847.4 5850.7 5893.6 3472.6 3580.2 3609.3 3622.9 3629.5 6557.9 6559.9 6560.4 6635.3 6685.1 7054.0 7054.9 7067.2 7077.3 7104.9 6534.6 6566.9 6620.8 6624.1 6659.2 6674.3 6696.9 6777.9 6824.4 6854.5 6696.5 6746.2 6778.1 6783.3 6893.0 6646.6 6651.3 6682.0 6738.9 6739.0 5070.7 5079.6 5080.5 5099.9 5106.2 6678.3 6817.6 6865.8 6889.5 6890.6 6554.8 6583.4 6619.5 6656.3 6672.4 6561.5 6607.8 6652.5 6654.9 6665.4 6490.2 6575.3 6604.6 6609.3 6615.9 6552.6 6554.9 6613.7 6616.2 6678.3 6193.7 6258.5 6391.5 6395.8 6497.4 16:08:34 INFO - PID 15765 | 16:08:34 INFO - PID 15765 | [#5] yui.html Cycles:180 Average:22689.54 Median:19258.26 stddev:31206.28 (162.0%) stddev-sans-first:31250.93 16:08:34 INFO - PID 15765 | Values: 900.3 901.4 915.0 916.6 923.3 18308.5 19153.3 19237.2 19252.3 19256.9 19259.6 19280.1 19457.0 19497.2 19540.7 980.8 986.1 1001.6 1004.9 1007.0 893.2 983.8 994.8 1011.3 1012.1 1049.3 1049.8 1050.8 1052.5 1054.6 1024.7 1052.8 1054.7 1055.9 1056.3 769.1 769.3 770.3 776.3 777.2 19115.7 19978.4 20086.3 20173.0 20197.0 20810.5 21244.7 21412.6 21474.1 21705.6 16107.4 16724.2 16885.3 16902.7 17011.8 3692.9 3702.5 3716.3 3730.9 3740.5 124997.0 125912.0 129912.4 130472.0 130527.0 16185.7 16346.5 16743.0 16751.3 16924.7 28971.4 29031.1 29614.3 29660.6 30197.0 8966.7 9058.9 9126.5 9135.6 9166.4 4041.8 4054.6 4107.2 4118.6 4159.7 5224.2 5228.4 5261.1 5265.4 5287.9 1012.6 1034.8 1037.0 1039.2 1047.1 677.2 681.1 708.5 710.4 716.1 10964.9 11204.9 11257.4 11740.4 12551.3 685.5 685.7 689.2 695.6 700.1 5167.7 5218.2 5319.3 5782.6 5807.0 104995.5 105281.0 105949.5 109537.8 111359.0 90588.0 94032.0 95943.0 95956.0 97889.5 79236.0 82572.2 82887.0 83999.0 84788.0 11956.7 12278.3 12291.2 12344.8 12410.9 38126.0 38364.0 38576.4 39776.2 40874.6 51250.7 51742.2 52141.5 52790.5 53165.5 17719.9 17992.7 18003.9 18026.1 18088.4 18454.5 18542.4 18658.7 18726.1 18892.2 16594.4 16749.5 16852.0 16905.9 17163.7 16638.8 16667.7 16758.6 16765.6 17124.2 15909.7 16088.6 16236.6 16377.4 16740.5 11435.4 11446.8 11673.2 11735.6 11752.1 11549.6 11790.9 11805.3 11965.5 12148.6 16:08:34 INFO - PID 15765 | -------- Summary: end -------- 16:08:34 INFO - PID 15765 | 16:08:35 INFO - TEST-INFO | 15765: exit 0 16:08:35 INFO - TEST-OK | dromaeo_css | took 1115186ms 16:08:35 INFO - TEST-START | kraken 16:08:35 INFO - Initialising browser for kraken test... 16:08:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38095/getInfo.html -profile /tmp/tmp0Mw73S/profile 16:08:35 INFO - TEST-INFO | started process 16149 (/builds/slave/test/build/application/firefox/firefox http://localhost:38095/getInfo.html) 16:08:41 INFO - TEST-INFO | 16149: exit 0 16:08:41 INFO - Browser initialized. 16:08:41 INFO - Running cycle 1/1 for kraken test... 16:08:41 INFO - Using env: {'DISPLAY': ':0', 16:08:41 INFO - 'HOME': '/home/cltbld', 16:08:41 INFO - 'JSGC_DISABLE_POISONING': '1', 16:08:41 INFO - 'LANG': 'en_US.UTF-8', 16:08:41 INFO - 'LANGUAGE': 'en_US:en', 16:08:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:08:41 INFO - 'LOGNAME': 'cltbld', 16:08:41 INFO - 'MAIL': '/var/mail/cltbld', 16:08:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:41 INFO - 'MOZ_ACCELERATED': '1', 16:08:41 INFO - 'MOZ_CRASHREPORTER': '1', 16:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:08:41 INFO - 'MOZ_NO_REMOTE': '1', 16:08:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:41 INFO - 'MOZ_WEBRENDER': '1', 16:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:41 INFO - 'NO_EM_RESTART': '1', 16:08:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:41 INFO - 'PWD': '/builds/slave/test', 16:08:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:41 INFO - 'RUST_BACKTRACE': 'full', 16:08:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:08:41 INFO - 'SHELL': '/bin/bash', 16:08:41 INFO - 'SHLVL': '1', 16:08:41 INFO - 'TERM': 'linux', 16:08:41 INFO - 'TMOUT': '86400', 16:08:41 INFO - 'USER': 'cltbld', 16:08:41 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131', 16:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:41 INFO - '_': '/tools/buildbot/bin/python'} 16:08:41 INFO - TEST-INFO | started process 16344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Mw73S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:42 INFO - PID 16344 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:08:43 INFO - PID 16344 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:08:43 INFO - PID 16344 | 16:08:43 INFO - PID 16344 | (/builds/slave/test/build/application/firefox/firefox:16405): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:08:43 INFO - PID 16344 | 16:08:53 INFO - PID 16344 | RSS: Main: 199290880 16:08:53 INFO - PID 16344 | 16:08:56 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38095/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:57 INFO - PID 16344 | RSS: Main: 203845632 16:08:57 INFO - PID 16344 | 16:08:59 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38095/tests/kraken/driver.html?testName=audio-dft) 16:09:00 INFO - PID 16344 | RSS: Main: 205709312 16:09:00 INFO - PID 16344 | 16:09:03 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38095/tests/kraken/driver.html?testName=audio-fft) 16:09:04 INFO - PID 16344 | RSS: Main: 199602176 16:09:04 INFO - PID 16344 | 16:09:06 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38095/tests/kraken/driver.html?testName=audio-oscillator) 16:09:06 INFO - PID 16344 | RSS: Main: 201768960 16:09:06 INFO - PID 16344 | 16:09:09 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:09 INFO - PID 16344 | RSS: Main: 201125888 16:09:09 INFO - PID 16344 | 16:09:12 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38095/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:13 INFO - PID 16344 | RSS: Main: 204328960 16:09:13 INFO - PID 16344 | 16:09:17 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38095/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:17 INFO - PID 16344 | RSS: Main: 202428416 16:09:17 INFO - PID 16344 | 16:09:20 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38095/tests/kraken/driver.html?testName=json-parse-financial) 16:09:21 INFO - PID 16344 | RSS: Main: 204386304 16:09:21 INFO - PID 16344 | 16:09:22 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:23 INFO - PID 16344 | RSS: Main: 204079104 16:09:23 INFO - PID 16344 | 16:09:25 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:25 INFO - PID 16344 | RSS: Main: 203198464 16:09:25 INFO - PID 16344 | 16:09:28 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:28 INFO - PID 16344 | RSS: Main: 205008896 16:09:28 INFO - PID 16344 | 16:09:31 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:32 INFO - PID 16344 | RSS: Main: 203792384 16:09:32 INFO - PID 16344 | 16:09:35 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:35 INFO - PID 16344 | RSS: Main: 204410880 16:09:35 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | Cycle 1(1): loaded http://localhost:38095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38095/tests/kraken/driver.html?testName=ai-astar) 16:09:37 INFO - PID 16344 | RSS: Main: 206991360 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | __start_tp_report 16:09:37 INFO - PID 16344 | _x_x_mozilla_page_load 16:09:37 INFO - PID 16344 | _x_x_mozilla_page_load_details 16:09:37 INFO - PID 16344 | |i|pagename|runs| 16:09:37 INFO - PID 16344 | |0;ai-astar;97;108;99;108;118;115;112;100;113;110 16:09:37 INFO - PID 16344 | |1;audio-beat-detection;153;123;165;174;116;145;150;119;178;118 16:09:37 INFO - PID 16344 | |2;audio-dft;166;164;165;162;162;186;166;172;163;165 16:09:37 INFO - PID 16344 | |3;audio-fft;84;80;83;160;75;86;74;94;99;83 16:09:37 INFO - PID 16344 | |4;audio-oscillator;83;87;134;80;80;81;133;85;80;125 16:09:37 INFO - PID 16344 | |5;imaging-gaussian-blur;115;114;123;117;121;122;115;115;121;115 16:09:37 INFO - PID 16344 | |6;imaging-darkroom;149;151;149;152;150;155;157;152;155;148 16:09:37 INFO - PID 16344 | |7;imaging-desaturate;99;97;94;94;110;98;100;95;95;94 16:09:37 INFO - PID 16344 | |8;json-parse-financial;58;53;58;55;53;58;53;53;52;52 16:09:37 INFO - PID 16344 | |9;json-stringify-tinderbox;38;42;49;42;40;46;38;46;39;45 16:09:37 INFO - PID 16344 | |10;stanford-crypto-aes;76;80;78;81;76;76;76;75;79;74 16:09:37 INFO - PID 16344 | |11;stanford-crypto-ccm;119;127;118;122;116;128;127;132;124;164 16:09:37 INFO - PID 16344 | |12;stanford-crypto-pbkdf2;176;172;177;177;174;179;187;178;176;174 16:09:37 INFO - PID 16344 | |13;stanford-crypto-sha256-iterative;66;67;65;66;67;67;64;68;67;66 16:09:37 INFO - PID 16344 | __end_tp_report 16:09:37 INFO - PID 16344 | __start_cc_report 16:09:37 INFO - PID 16344 | _x_x_mozilla_cycle_collect,911 16:09:37 INFO - PID 16344 | __end_cc_report 16:09:37 INFO - PID 16344 | __startTimestamp1504307377865__endTimestamp 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | ------- Summary: start ------- 16:09:37 INFO - PID 16344 | Number of tests: 14 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#0] ai-astar Cycles:10 Average:108.00 Median:114.00 stddev:7.15 (6.3%) stddev-sans-first:6.38 16:09:37 INFO - PID 16344 | Values: 97.0 108.0 99.0 108.0 118.0 115.0 112.0 100.0 113.0 110.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.50 stddev:23.90 (15.8%) stddev-sans-first:25.13 16:09:37 INFO - PID 16344 | Values: 153.0 123.0 165.0 174.0 116.0 145.0 150.0 119.0 178.0 118.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#2] audio-dft Cycles:10 Average:167.10 Median:165.50 stddev:7.23 (4.4%) stddev-sans-first:7.66 16:09:37 INFO - PID 16344 | Values: 166.0 164.0 165.0 162.0 162.0 186.0 166.0 172.0 163.0 165.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#3] audio-fft Cycles:10 Average:91.80 Median:83.50 stddev:25.16 (30.1%) stddev-sans-first:26.52 16:09:37 INFO - PID 16344 | Values: 84.0 80.0 83.0 160.0 75.0 86.0 74.0 94.0 99.0 83.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:80.50 stddev:23.60 (29.3%) stddev-sans-first:24.49 16:09:37 INFO - PID 16344 | Values: 83.0 87.0 134.0 80.0 80.0 81.0 133.0 85.0 80.0 125.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:119.00 stddev:3.52 (3.0%) stddev-sans-first:3.59 16:09:37 INFO - PID 16344 | Values: 115.0 114.0 123.0 117.0 121.0 122.0 115.0 115.0 121.0 115.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:152.00 stddev:3.01 (2.0%) stddev-sans-first:3.02 16:09:37 INFO - PID 16344 | Values: 149.0 151.0 149.0 152.0 150.0 155.0 157.0 152.0 155.0 148.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:95.00 stddev:4.88 (5.1%) stddev-sans-first:5.15 16:09:37 INFO - PID 16344 | Values: 99.0 97.0 94.0 94.0 110.0 98.0 100.0 95.0 95.0 94.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.55 (4.7%) stddev-sans-first:2.37 16:09:37 INFO - PID 16344 | Values: 58.0 53.0 58.0 55.0 53.0 58.0 53.0 53.0 52.0 52.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#9] json-stringify-tinderbox Cycles:10 Average:42.50 Median:43.50 stddev:3.84 (8.8%) stddev-sans-first:3.71 16:09:37 INFO - PID 16344 | Values: 38.0 42.0 49.0 42.0 40.0 46.0 38.0 46.0 39.0 45.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:2.28 (3.0%) stddev-sans-first:2.39 16:09:37 INFO - PID 16344 | Values: 76.0 80.0 78.0 81.0 76.0 76.0 76.0 75.0 79.0 74.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:13.70 (10.8%) stddev-sans-first:14.17 16:09:37 INFO - PID 16344 | Values: 119.0 127.0 118.0 122.0 116.0 128.0 127.0 132.0 124.0 164.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.00 stddev:4.08 (2.3%) stddev-sans-first:4.31 16:09:37 INFO - PID 16344 | Values: 176.0 172.0 177.0 177.0 174.0 179.0 187.0 178.0 176.0 174.0 16:09:37 INFO - PID 16344 | 16:09:37 INFO - PID 16344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 16:09:37 INFO - PID 16344 | Values: 66.0 67.0 65.0 66.0 67.0 67.0 64.0 68.0 67.0 66.0 16:09:37 INFO - PID 16344 | -------- Summary: end -------- 16:09:37 INFO - PID 16344 | 16:09:38 INFO - PID 16344 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:09:38 INFO - TEST-INFO | 16344: exit 0 16:09:38 INFO - TEST-OK | kraken | took 63213ms 16:09:38 INFO - SUITE-END | took 1178s 16:09:39 INFO - Completed test suite (00:19:38) 16:09:39 INFO - javascript benchmark 16:09:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8535.819731025978, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.6744325567447, 3265.8530366133523, 3271.1822044488877, 3286.293446908914, 3290.161008942719, 6314.116023756666, 6314.589551679143, 6397.456216221621, 6398.232212134544, 6519.478441724663, 6455.935440645592, 6506.707198176082, 6564.606123632585, 6568.441682456997, 6608.801735947929, 5820.185174075633, 5904.321003084636, 5914.260717410324, 5927.703614819242, 5955.702214889249, 5895.4399332063385, 5905.881882362351, 6019.3980601939675, 6024.909626355608, 6028.0, 5885.440883116097, 5916.319623243339, 6012.579119461661, 6016.127661489081, 6016.27804663441, 5903.173555702205, 5942.316633587149, 5949.524038076944, 5992.49063829575, 6037.094435834616, 5770.8268751937085, 5817.825465236049, 5871.031279838864, 5934.0, 5950.5834591578605, 6367.999999999954, 6408.67956602168, 6423.582467139668, 6471.320511346288, 6477.578957367803, 6895.965520172417, 6908.0, 6992.825179370506, 7004.334588214111, 7007.229204787469, 6962.65186740666, 6964.79105626832, 6965.825854353631, 7051.506394552383, 7067.399271061966, 6297.905531417033, 6422.165118534561, 6434.420902118832, 6465.062565927914, 6552.0, 7044.295570443017, 7135.7859264221115, 7139.214686384494, 7203.351698347174, 7217.097862767154, 6744.494162937799, 6812.829679258059, 6850.040994260808, 6902.758403455855, 6913.170419549686, 6907.827304317432, 6915.031895534629, 6974.79075627732, 7002.964985175042, 7016.684249208798, 6700.296468870796, 6854.725810967506, 6871.415929646036, 6958.617276049765, 6960.79117626472, 6793.762218322335, 6858.3141685831015, 6896.172459304815, 6903.482238832108, 6905.0, 5415.079436495806, 5471.917921231185, 5484.177373394023, 5487.067198576172, 5491.313585801775, 4772.49888761682, 4845.9030819383415, 4851.684640498356, 4852.80588776445, 4879.926801097987, 6025.548083893726, 6035.30593981689, 6108.961476548998, 6127.601705889103, 6129.0, 6739.59562426256, 6933.5493192942295, 6955.1653801543125, 6965.965170174117, 7032.367086962198, 5902.498287645598, 5953.761849526057, 6009.429104235091, 6015.0, 6060.666663333471, 5921.763129474859, 5940.70296485174, 5949.345571987078, 5999.790007349722, 6008.188894499274, 6662.633555154416, 6751.831204219934, 6757.391834734897, 6776.728930842711, 6784.626845523445, 6734.292899245705, 6927.89608155868, 6928.0, 7003.54476958996, 7006.404455621329, 6564.212294524687, 6602.60384376939, 6608.570442921195, 6619.569727967667, 6622.337766223532, 6624.403803657694, 6699.799006029827, 6708.597484150967, 6719.966400167968, 6728.226253980855, 6846.828829279308, 6858.862822743417, 6862.965685171542, 6868.038474613458, 6870.931290687229, 5691.345495267931, 6566.343365663395, 6611.438027767694, 6714.0, 6797.694103765243, 6714.764983225564, 6753.831154221184, 6760.290169532128, 6820.079289295882, 6852.931470685229, 6484.70818813164, 6610.8016759497295, 6629.303923088007, 6645.335466453316, 6750.8649827004165, 6666.966665166643, 6795.932040679728, 6798.354156355138, 6850.314968503109, 6893.517453778388, 6431.871362572629, 6527.412532871875, 6538.574992625464, 6594.10979517759, 6625.105610742488], "value": 6300.080568299904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.3257696112228, 818.1205204405262, 847.195164593636, 864.1099667342639, 872.5201139373345, 39173.0, 39735.60264397355, 39844.60155398445, 40081.19837603246, 40300.59699403005, 37137.628623713754, 37365.0, 37453.625463745426, 37462.43806342907, 37499.250014999685, 6877.8624427511295, 6885.758998435056, 6894.517383783137, 6948.617826019567, 6962.791116266495, 6894.655267236643, 6897.241303456641, 6939.37545620894, 6980.37176654101, 6988.790336289894, 6956.513044086916, 7624.466287359859, 7719.266669666373, 7745.883811742829, 7800.609969501531, 7659.961700191491, 7707.96146019272, 7712.845743085163, 7714.459987800856, 7720.150783413848, 7444.925550744478, 7582.810429739246, 7659.387249020065, 7666.578338191397, 7674.42441816866, 37096.258074838355, 37267.0, 37516.624833751855, 37579.81210093959, 37583.62416375856, 3551.627079156703, 3591.892243232707, 3598.3702852000797, 3601.603823579404, 3605.9098522537147, 30766.53850192249, 30827.0, 30956.380872382426, 31029.37941241185, 31047.534286985712, 5135.512126347991, 5191.532762051434, 5193.272941788115, 5241.68549887008, 5293.39126000511, 182667.08666456715, 183341.0, 185060.0, 185157.0, 185444.0, 46904.29643555349, 47442.0, 47492.0, 47521.28718069162, 47571.28643070357, 49707.50292497101, 49776.25335619968, 49825.50174498281, 50015.24977125346, 50045.49954500408, 13859.376328065262, 14122.646933826736, 14177.0, 14202.360893759806, 14208.573742787732, 11265.436728163559, 11337.886621133848, 11397.658070257905, 11399.430028498708, 11401.315921044765, 13759.17444953286, 13866.376013079436, 14012.929935350461, 14115.50595729165, 14132.646683832987, 5634.32388113429, 5727.083666613322, 5758.942410575924, 5784.132380142928, 5821.15593238978, 999.9550020249106, 1007.2697294461603, 1014.4572653630272, 1017.4048181813722, 1028.6348346337093, 22385.44036399103, 22583.54832903333, 22708.318750437513, 22728.20451284197, 22818.0, 1094.7099018760034, 1104.5857803323754, 1107.7950579142885, 1111.716512289361, 1130.6268931252666, 11971.475545827545, 12065.638030859089, 12120.333381664093, 12182.329971851634, 12235.97306188867, 217071.0, 217109.0, 218170.0, 219574.0, 221022.0, 43776.0, 50190.74904625527, 50285.24572131421, 51127.23309150366, 51208.23187652114, 1424.1099312929418, 1441.5315022617692, 1444.6316189371853, 1450.376338174595, 1451.4702133721328, 26325.473490529697, 26360.20919372422, 26537.60193597059, 27096.458070838868, 27151.0, 35844.0, 36151.27697445984, 36215.81892090523, 36375.63624363722, 36398.0, 191272.0, 191746.0, 192135.0, 193485.0, 193490.0, 33314.0, 33339.66660333366, 33417.33165336631, 33614.83192584021, 33618.0, 40423.1915361697, 41471.37792933169, 41816.790916045225, 41937.16125677408, 41958.790206048776, 31284.530732038584, 31303.530447042856, 31742.841285793424, 32111.0, 32341.676583233868, 29817.25456863596, 31072.378552429276, 31339.843300783352, 31592.842035789676, 31638.841805790824, 35576.110597235274, 35582.46626300556, 35755.821220893726, 35802.0, 35837.46243806397, 30911.536326955564, 30922.536161957138, 31227.53158702576, 31616.367672646877, 31633.20916977002, 22264.685632178534, 22989.770102298764, 23151.189708360125, 23186.188483403, 23279.650805237598], "value": 16690.857606000696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1889198446223, 568.074039315915, 569.0269638917454, 582.2111039541421, 590.4243362721346, 22428.88785556072, 22947.196848110318, 22957.08171673131, 22966.196183133572, 22982.0, 23642.0, 24734.62898056526, 25963.0, 26136.215913522577, 26213.213603591874, 6742.696578653972, 6870.0, 6888.207856096538, 6906.0, 6934.4452443804375, 6808.59148451092, 6849.691763870613, 6850.588964662112, 6862.828429289258, 6882.346177113166, 4172.0, 4173.373993900924, 5043.924341134886, 6583.242927063401, 6825.761098361559, 6502.5448218624715, 6525.1517302750335, 6550.836229094263, 6554.14796076507, 6554.9344506555035, 6058.697065146725, 6075.787347442818, 6088.4215999479975, 6092.5430592705725, 6125.418085281935, 27906.720932790617, 28665.426691466262, 29114.41771164586, 29133.0, 29143.271418214714, 1943.6695761720541, 1976.3379267945256, 1978.9802101979085, 1979.604079184169, 1980.8712433691908, 19614.41156765285, 20120.49698757543, 20223.08996095179, 20230.595388092155, 20257.594848102955, 2367.8342516023886, 2412.770786775271, 2417.613181890889, 2419.0444774314224, 2461.2247142150163, 125855.0, 126234.0, 126868.0, 127709.0, 128334.35832820776, 13957.511487097903, 14391.208483533506, 14428.0, 14797.704045919021, 14813.777793333109, 22207.1117155312, 22373.440663983532, 22375.44061398478, 22443.43891402728, 22665.320040398816, 9671.419714817133, 9855.90144098564, 9918.80162396748, 9958.55186516594, 10045.648402306031, 9012.63949442028, 9059.275257979345, 9141.3601047926, 9143.039980802054, 9182.449053056838, 8836.558172091498, 8841.16008979146, 9235.722928312027, 9482.780162827476, 9557.378770379903, 2685.4763321152186, 2747.4779791839487, 2760.2271364018106, 2771.9584206236923, 2790.0, 952.8046750416148, 956.4309236004566, 962.9614815407306, 977.5894124467599, 985.7831277119022, 18791.50365007282, 18905.81094189068, 19128.61742765137, 19201.32795352156, 19616.411507654793, 1015.761296095417, 1050.2543194332109, 1055.5250137438184, 1056.5404049238605, 1061.5117046158853, 10484.161267098614, 10633.255672102878, 10634.255602107778, 10710.0, 10842.024217820433, 490882.0, 492988.0, 497890.0, 499323.0, 503385.0, 118159.40920295515, 118938.0, 120160.39919800345, 123238.38380808038, 128066.0, 1231.199720181889, 1246.5512415530402, 1247.6880779804867, 1279.0279387665441, 1287.1826390242263, 20261.6960745586, 20692.793072069086, 21413.46466338354, 21599.676004859626, 21630.89184554067, 58101.418985811295, 59391.0, 60587.0, 61226.69386653038, 61490.0, 72008.0, 72044.63977680077, 73202.26797732168, 75073.62463187867, 76520.23479765131, 19397.2241110354, 20073.29743458972, 20073.297434590302, 20127.899360503103, 20467.69298460554, 22677.092916283164, 22760.0, 23297.0, 23379.0, 23390.064397424594, 19121.71317430212, 19498.22007119756, 19503.60992780108, 19525.70711439301, 19674.90162549178, 16901.239444225284, 17007.14964251807, 17406.39077632277, 17617.119144042492, 17879.553011174303, 19909.800901991373, 20006.199752009758, 20038.49903752418, 20106.698399523728, 20280.087396066916, 19421.126049327533, 20006.0, 20250.59498809986, 20293.797062029782, 20689.27587534429, 17643.0, 18066.81933180704, 18141.45575632733, 18166.455006349832, 18244.817551824843], "value": 12243.56874086019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.2168509736707, 1328.9269090200034, 1349.439982407301, 1355.7017456159642, 1366.057420379938, 14427.206503642296, 15030.398784048639, 15071.62320941977, 15160.696786064273, 15354.69290614187, 15713.214339283048, 15839.762403563927, 16034.518964431056, 16048.197590120506, 16088.919555402235, 2775.528160212764, 2801.29967508123, 2807.705190954951, 2809.9157025289273, 2812.606235127084, 2659.2687011071916, 2724.7956403269736, 2819.126070918012, 2820.083472871315, 2829.038127036807, 2791.148699646607, 2801.229661842989, 2871.181713211735, 2871.325238568945, 2875.151830210093, 2687.731226877316, 2688.07261494784, 2719.6600424946882, 2739.1919383781833, 2745.8627068646488, 2732.1120635793445, 2758.724127587245, 2767.5848622706753, 2786.5959435881887, 2789.4839454700946, 14927.552173434815, 15218.163001034938, 15275.0, 15288.388464461408, 15299.464518741903, 8047.114817370085, 8361.372897032747, 8363.916360836436, 8374.581270936429, 8375.41372103947, 5461.590380721462, 5511.949562582458, 5580.218769372291, 5600.327960644708, 5729.627574207663, 1896.2035944903037, 1917.9136938837646, 1939.3115444017312, 1962.931297404584, 1969.5962327722782, 26728.331791705168, 26894.5965810513, 26947.86526067357, 27009.0, 27019.459610807673, 6637.46900247979, 6736.157980252468, 6787.136112714387, 6878.896816547755, 6957.582545047313, 16228.0, 16302.0, 16304.51086467408, 16309.755353669705, 16330.428435004718, 7719.150893401721, 7908.644111015018, 7917.802054948673, 7918.406119541058, 7929.04851417822, 7193.604351760599, 7223.2415596361625, 7306.561606303639, 7322.267773222635, 7362.226966168475, 4683.859484215479, 4982.202847544376, 5100.2349647553165, 5111.080005598954, 5113.437521872591, 1335.8463776665808, 1505.8795296376263, 1515.1515151514966, 1525.3745964154643, 1544.783730277762, 859.1623167411849, 888.6445421831319, 890.3322508118911, 891.8394688955921, 896.8744375787395, 7183.245759195313, 7188.137423509213, 7225.927740722525, 7273.127224733066, 7283.70865165398, 947.1381043250609, 958.1424624960761, 961.6778379242892, 965.0928127560071, 966.4826222830089, 4262.339337402707, 4431.113777244564, 4437.866863994085, 4444.911101777946, 4466.59800617946, 21239.78760212409, 21379.0, 21632.459188520414, 21791.782082179292, 21921.0, 21158.47103822417, 21253.17442860269, 21640.0, 21844.78155218459, 21933.0, 10618.840717389245, 10623.0, 10678.733031674115, 10741.570337186426, 10817.783644327226, 7654.250725136888, 7771.0, 7874.881876771968, 7905.960470197612, 7930.801729956797, 18073.548161296072, 18737.718934215725, 18745.531361716065, 19016.144273508, 19029.71455428142, 19120.713189301892, 19140.138693758538, 19458.8054119457, 19497.902510487358, 19677.704834427783, 10872.61945831892, 10938.234323597271, 10942.726431839268, 10949.83575246356, 11061.391623460466, 13987.510437134652, 14421.78367324512, 14494.565163045125, 14567.708645826811, 14584.124952502883, 11499.597514086967, 11638.6508404748, 11843.822342664695, 11860.288382697066, 12032.037437005194, 11147.609833655782, 11347.659570212907, 11453.083753299883, 11477.311361318347, 11484.368359740294, 9031.50326732036, 9066.773330666521, 9102.271818254392, 9103.954480227556, 9114.954425227832, 6792.354726300993, 6974.965125174342, 6986.685599147949, 7016.7544135954995, 7104.538205016657, 6850.246472887879, 6912.896306555506, 7019.6490175492045, 7025.332593403618, 7080.291970803085], "value": 6607.333896438236, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.527289371822, 503.1158312121105, 523.8926020165865, 527.4593541619837, 527.7071225469863, 6471.546991710582, 6487.41613254807, 6502.821554779154, 6530.510211734121, 6531.673416329182, 6151.846203844906, 6210.19267495225, 6273.874522509547, 6319.936800631992, 6355.205599300088, 4971.179755340382, 5063.215201643751, 5102.821401250957, 5104.923426148611, 5136.948630513703, 4871.585915197213, 5126.384833819928, 5133.435322114583, 5161.793528258865, 5180.715060671661, 4938.308636790852, 5007.624428167884, 5058.620603454738, 5075.543201111899, 5117.257997590347, 5007.899842003176, 5009.499050094998, 5014.799408023693, 5084.957583695334, 5087.186050231963, 4531.207038768202, 4537.0, 4547.47704014036, 4580.221362368406, 4605.700629459108, 6225.968870155665, 6228.937710622881, 6259.561830671855, 6271.498280137624, 6274.937250627481, 5783.942160578383, 5790.189373487715, 5842.18209450673, 5853.268341457318, 5884.499817515516, 6578.5395022347975, 6593.637349945751, 6595.901061484082, 6607.0, 6684.2981486944145, 4907.730074845882, 4947.282644016597, 4949.109160351135, 4953.628477864138, 4960.0, 7003.54476958996, 7095.929040709579, 7106.893396599055, 7134.607596582134, 7135.714571417137, 5009.799608015712, 5057.266696329012, 5101.948980510221, 5116.181410974301, 5123.692578445305, 5027.120253955543, 5043.89034412436, 5049.671771334852, 5058.620603454756, 5105.795768169231, 5687.829365119053, 5693.629914055573, 5785.132230165509, 5808.099744539603, 5814.505767009767, 6614.768483103068, 6723.394894459424, 6792.0, 6802.727890884309, 6842.863142737217, 1684.5788552861784, 1685.5954570902895, 1714.2800023989955, 1752.815954324803, 1757.7275522294065, 1183.1126655008743, 1219.4634360881184, 1234.9320787356603, 1237.5297386992886, 1244.9439775209955, 5843.159404787479, 5854.619449735754, 5861.856937897154, 5880.500157486576, 5952.464278214981, 6674.766383176566, 6706.530542861953, 6752.493562982796, 6753.602471122681, 6763.6618169092335, 5764.74058667361, 5772.7113644317615, 5847.44449277318, 5850.736716847752, 5893.646381217055, 3472.6353732858192, 3580.230250496156, 3609.3322735294055, 3622.927541449209, 3629.510016147839, 6557.901631475532, 6559.868802623921, 6560.44236239925, 6635.303293154246, 6685.061332213701, 7053.964730176419, 7054.894176587355, 7067.22260551339, 7077.292270772985, 7104.92895071053, 6534.607923524603, 6566.868662626816, 6620.768273110418, 6624.138861947916, 6659.2008958925235, 6674.292336202086, 6696.866062678621, 6777.89833152513, 6824.385805277549, 6854.485913556404, 6696.526764111888, 6746.224184218878, 6778.102131403215, 6783.253842077466, 6893.0, 6646.567973081735, 6651.33486651331, 6682.0, 6738.932610674026, 6738.9554619034125, 5070.6957582545165, 5079.593632509316, 5080.517350851663, 5099.87250318745, 5106.208537676666, 6678.265390807104, 6817.5568588041615, 6865.828354290983, 6889.517733758589, 6890.586564806128, 6554.770583029571, 6583.407493325432, 6619.470442364503, 6656.267810540933, 6672.4328432081875, 6561.507886908405, 6607.7710265429205, 6652.534322597372, 6654.866902661823, 6665.366790154928, 6490.156279683611, 6575.342465753386, 6604.570702904296, 6609.272979972296, 6615.900761488678, 6552.63960482159, 6554.934450655433, 6613.735450581923, 6616.152282387706, 6678.297034256234, 6193.690315484298, 6258.499320054294, 6391.456726178327, 6395.808125756234, 6497.426415471377], "value": 5130.540630609189, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.3157600223828, 901.3555307954813, 915.0483497162951, 916.6012784438769, 923.3029063057388, 18308.45074647761, 19153.329633462832, 19237.23051077955, 19252.326168584103, 19256.90371548142, 19259.614807703838, 19280.132394042266, 19457.0, 19497.220111195536, 19540.70688939667, 980.7989362180735, 986.058314309836, 1001.5743309093642, 1004.8593196952432, 1007.028217769852, 893.1916615462984, 983.822911875862, 994.7662299359681, 1011.3375738891039, 1012.084063922148, 1049.2917280835443, 1049.7847941172042, 1050.7793363393696, 1052.5211028981794, 1054.5781687325054, 1024.6516184497307, 1052.763128296131, 1054.6941386997762, 1055.9472026398687, 1056.2922841696006, 769.0655853138408, 769.2922511289571, 770.2720928722359, 776.3362325211918, 777.1645481107776, 19115.71326430105, 19978.400647980583, 20086.296979605642, 20173.0, 20197.0, 20810.47973800667, 21244.681329780065, 21412.57174856494, 21474.141034358607, 21705.565888682137, 16107.436239731553, 16724.163791810362, 16885.324587016505, 16902.74645880313, 17011.829881701273, 3692.8522859085606, 3702.500162478058, 3716.2567486502808, 3730.850765969385, 3740.4576336431337, 124997.0, 125912.0, 129912.35043824815, 130472.0, 130527.0, 16185.676286474205, 16346.50960471164, 16743.0, 16751.32994680199, 16924.746128808078, 28971.42057158845, 29031.12906612805, 29614.259643508653, 29660.555091673643, 30197.0, 8966.68616598416, 9058.864117038249, 9126.45241285525, 9135.588898499584, 9166.358354915224, 4041.7574945503366, 4054.5945405459806, 4107.158032603309, 4118.588141185917, 4159.688023398257, 5224.242484839677, 5228.398734145546, 5261.105612045962, 5265.447128051499, 5287.867803304871, 1012.5645972231864, 1034.8344264917578, 1036.9637062702768, 1039.1738567838586, 1047.1047254597363, 677.2279601254573, 681.1077488489994, 708.5217478202296, 710.3784188834769, 716.0583832260561, 10964.945175274073, 11204.887951120547, 11257.380844053656, 11740.354280514654, 12551.3096779678, 685.5030103175158, 685.6811582614108, 689.1867596236389, 695.58265040975, 700.0898831519005, 5167.689938603696, 5218.217267409919, 5319.255304257407, 5782.624129431573, 5807.0, 104995.47502262439, 105281.0, 105949.47025264824, 109537.8063045504, 111359.0, 90588.0, 94032.0, 95943.0, 95956.0, 97889.51055244678, 79236.0, 82572.17427825645, 82887.0, 83999.0, 84788.0, 11956.70108247266, 12278.283796740187, 12291.201071930296, 12344.81482777741, 12410.875891240972, 38126.0, 38364.0, 38576.42135368028, 39776.20447590974, 40874.59125408708, 51250.74374628103, 51742.223866641274, 52141.47858521366, 52790.47209528009, 53165.468345316054, 17719.91140044343, 17992.730109048112, 18003.909980450015, 18026.098695065455, 18088.366907158186, 18454.538636533656, 18542.44372668822, 18658.72011919795, 18726.063696815378, 18892.244310227437, 16594.419195328104, 16749.497515074567, 16852.0, 16905.91547042257, 17163.656726865644, 16638.750418743486, 16667.74998375001, 16758.58103547421, 16765.580860478585, 17124.229409676343, 15909.681806363576, 16088.597785055466, 16236.594085147493, 16377.42679006229, 16740.49778506647, 11435.428228588704, 11446.828297575377, 11673.182877198855, 11735.589254376056, 11752.11859110553, 11549.595764148215, 11790.882091178979, 11805.291682499077, 11965.461554230254, 12148.635540933787], "value": 8861.856472027397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 99.0, 108.0, 118.0, 115.0, 112.0, 100.0, 113.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 165.0, 174.0, 116.0, 145.0, 150.0, 119.0, 178.0, 118.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 162.0, 162.0, 186.0, 166.0, 172.0, 163.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 83.0, 160.0, 75.0, 86.0, 74.0, 94.0, 99.0, 83.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 134.0, 80.0, 80.0, 81.0, 133.0, 85.0, 80.0, 125.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 123.0, 117.0, 121.0, 122.0, 115.0, 115.0, 121.0, 115.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 152.0, 150.0, 155.0, 157.0, 152.0, 155.0, 148.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 94.0, 94.0, 110.0, 98.0, 100.0, 95.0, 95.0, 94.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 58.0, 55.0, 53.0, 58.0, 53.0, 53.0, 52.0, 52.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 42.0, 49.0, 42.0, 40.0, 46.0, 38.0, 46.0, 39.0, 45.0], "value": 42.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 78.0, 81.0, 76.0, 76.0, 76.0, 75.0, 79.0, 74.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 118.0, 122.0, 116.0, 128.0, 127.0, 132.0, 124.0, 164.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 177.0, 177.0, 174.0, 179.0, 187.0, 178.0, 176.0, 174.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 64.0, 68.0, 67.0, 66.0], "value": 66.3, "unit": "score"}]}]} 16:09:39 INFO - Return code: 0 16:09:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:39 INFO - # TBPL SUCCESS # 16:09:39 INFO - Running post-action listener: _package_coverage_data 16:09:39 INFO - Running post-action listener: _resource_record_post_action 16:09:39 INFO - [mozharness: 2017-09-01 23:09:39.151899Z] Finished run-tests step (success) 16:09:39 INFO - Running post-run listener: _resource_record_post_run 16:09:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 176128; Write bytes: 400568320; Read time: 116; Write time: 256604 16:09:39 INFO - TinderboxPrint: CPU usage
13.3% 16:09:39 INFO - TinderboxPrint: I/O read bytes / time
176,128 / 116 16:09:39 INFO - TinderboxPrint: I/O write bytes / time
400,568,320 / 256,604 16:09:39 INFO - TinderboxPrint: CPU idle
8,259.0 (86.7%) 16:09:39 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 16:09:39 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116838400; Read time: 0; Write time: 81044 16:09:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:09:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 176128; Write bytes: 283729920; Read time: 116; Write time: 175560 16:09:39 INFO - Running post-run listener: _upload_blobber_files 16:09:39 INFO - Blob upload gear active. 16:09:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:39 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:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:43 INFO - (blobuploader) - INFO - Done attempting. 16:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:09:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:44 INFO - (blobuploader) - INFO - Done attempting. 16:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:45 INFO - (blobuploader) - INFO - Done attempting. 16:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:46 INFO - (blobuploader) - INFO - Done attempting. 16:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:46 INFO - Return code: 0 16:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5314b7729df4ca0aa55ee3d648d1ea08e1fbf021d5a0865d55ce70db23b8b1b72c4ce514176ecf1a2647d67957bc4e75a3934e425c2fa182d83a3d0998d42c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/473934a5486df08ea96be4cd0a0847500c11a5d39b7e7236e89518deea9dc5687a63afd99875ba1422bea3af75e6d1e0462a4d5f78ce197d60343659b8e04b56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee64d7939a223c1347b46ee2f1f9139e1f6efb2307f72c3ff8c784bc01dcc2130c541c37f1745e88f41634f88c5fa7e3071e63187f0d4d5c3d706c9115322921", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2582afd1a1c3411e7991a656011aa2c3d65ef5cdd718481b4452b67ef81545cd9e63fcd5eba97d8a0f468504e54a318f9ad6732d5f8d57c99e8cd2fba9018f33"} 16:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:46 INFO - Contents: 16:09:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5314b7729df4ca0aa55ee3d648d1ea08e1fbf021d5a0865d55ce70db23b8b1b72c4ce514176ecf1a2647d67957bc4e75a3934e425c2fa182d83a3d0998d42c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/473934a5486df08ea96be4cd0a0847500c11a5d39b7e7236e89518deea9dc5687a63afd99875ba1422bea3af75e6d1e0462a4d5f78ce197d60343659b8e04b56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee64d7939a223c1347b46ee2f1f9139e1f6efb2307f72c3ff8c784bc01dcc2130c541c37f1745e88f41634f88c5fa7e3071e63187f0d4d5c3d706c9115322921", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2582afd1a1c3411e7991a656011aa2c3d65ef5cdd718481b4452b67ef81545cd9e63fcd5eba97d8a0f468504e54a318f9ad6732d5f8d57c99e8cd2fba9018f33"} 16:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:46 INFO - Copying logs to upload dir... 16:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.655915 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-01 16:09:46.319841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 16:09:46.323378) ========= 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=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5314b7729df4ca0aa55ee3d648d1ea08e1fbf021d5a0865d55ce70db23b8b1b72c4ce514176ecf1a2647d67957bc4e75a3934e425c2fa182d83a3d0998d42c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/473934a5486df08ea96be4cd0a0847500c11a5d39b7e7236e89518deea9dc5687a63afd99875ba1422bea3af75e6d1e0462a4d5f78ce197d60343659b8e04b56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee64d7939a223c1347b46ee2f1f9139e1f6efb2307f72c3ff8c784bc01dcc2130c541c37f1745e88f41634f88c5fa7e3071e63187f0d4d5c3d706c9115322921", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2582afd1a1c3411e7991a656011aa2c3d65ef5cdd718481b4452b67ef81545cd9e63fcd5eba97d8a0f468504e54a318f9ad6732d5f8d57c99e8cd2fba9018f33"} build_url:https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/B3zBBhhZS1Sz7X0NYgNFnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5314b7729df4ca0aa55ee3d648d1ea08e1fbf021d5a0865d55ce70db23b8b1b72c4ce514176ecf1a2647d67957bc4e75a3934e425c2fa182d83a3d0998d42c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/473934a5486df08ea96be4cd0a0847500c11a5d39b7e7236e89518deea9dc5687a63afd99875ba1422bea3af75e6d1e0462a4d5f78ce197d60343659b8e04b56", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee64d7939a223c1347b46ee2f1f9139e1f6efb2307f72c3ff8c784bc01dcc2130c541c37f1745e88f41634f88c5fa7e3071e63187f0d4d5c3d706c9115322921", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2582afd1a1c3411e7991a656011aa2c3d65ef5cdd718481b4452b67ef81545cd9e63fcd5eba97d8a0f468504e54a318f9ad6732d5f8d57c99e8cd2fba9018f33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 16:09:46.352346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 16:09:46.352692) ========= 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=199fb4c72b90437b990b419b000001c5-1504306131.854994-452850131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 16:09:46.435927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 16:09:46.436246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 16:09:46.436563) ========= ========= Total master_lag: 0.20 =========