builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1505814917.07 results: success (0) revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.068882) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.069374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.069648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.239088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.239414) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 02:55:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2017-09-19 02:55:17 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212701 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.541575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.541922) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018309 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:17.644274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-19 02:55:17.644619) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --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 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 02:55:17,980 truncating revision to first 12 chars 2017-09-19 02:55:17,980 Setting DEBUG logging. 2017-09-19 02:55:17,980 attempt 1/10 2017-09-19 02:55:17,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c12af6fd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 02:55:18,461 attempt 1/10 2017-09-19 02:55:19,100 current task status: no status available at this point. state: STARTED 2017-09-19 02:55:19,101 sleeping for 10.00s (attempt 1/10) 2017-09-19 02:55:29,111 attempt 2/10 2017-09-19 02:55:29,443 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-19 02:55:29,641 unpacking tar archive at: mozilla-central-7c12af6fd620/testing/mozharness/ program finished with exit code 0 elapsedTime=11.928984 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-19 02:55:29.599446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:29.599761) ========= script_repo_revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:29.605164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:29.605438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:29.628939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-19 02:55:29.629271) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:55:30 INFO - MultiFileLogger online at 20170919 02:55:30 in /builds/slave/test 02:55:30 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 02:55:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:30 INFO - {'append_to_log': False, 02:55:30 INFO - 'base_work_dir': '/builds/slave/test', 02:55:30 INFO - 'blob_upload_branch': 'Firefox', 02:55:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:30 INFO - 'branch': 'Firefox', 02:55:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:30 INFO - 'code_coverage': False, 02:55:30 INFO - 'config_files': ('talos/linux_config.py',), 02:55:30 INFO - 'default_actions': ('clobber', 02:55:30 INFO - 'read-buildbot-config', 02:55:30 INFO - 'download-and-extract', 02:55:30 INFO - 'populate-webroot', 02:55:30 INFO - 'create-virtualenv', 02:55:30 INFO - 'install', 02:55:30 INFO - 'setup-mitmproxy', 02:55:30 INFO - 'run-tests'), 02:55:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:30 INFO - 'disable_ccov_upload': False, 02:55:30 INFO - 'disable_stylo': False, 02:55:30 INFO - 'download_minidump_stackwalk': True, 02:55:30 INFO - 'download_symbols': 'ondemand', 02:55:30 INFO - 'enable_stylo': False, 02:55:30 INFO - 'enable_webrender': False, 02:55:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:55:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:30 INFO - 'gecko_profile': False, 02:55:30 INFO - 'gecko_profile_interval': 0, 02:55:30 INFO - 'installer_path': 'installer.exe', 02:55:30 INFO - 'log_level': 'info', 02:55:30 INFO - 'log_name': 'talos', 02:55:30 INFO - 'log_to_console': True, 02:55:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:55:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:55:30 INFO - 'opt_config_files': (), 02:55:30 INFO - 'pip_index': False, 02:55:30 INFO - 'suite': 'dromaeojs-e10s', 02:55:30 INFO - 'system_bits': '32', 02:55:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:30 INFO - 'title': 'talos-linux64-ix-037', 02:55:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:30 INFO - 'use_talos_json': True, 02:55:30 INFO - 'verify': 'False', 02:55:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:30 INFO - 'work_dir': 'build'} 02:55:30 INFO - [mozharness: 2017-09-19 09:55:30.155708Z] Running clobber step. 02:55:30 INFO - Running pre-action listener: _resource_record_pre_action 02:55:30 INFO - Running main action method: clobber 02:55:30 INFO - rmtree: /builds/slave/test/build 02:55:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:31 INFO - Running post-action listener: _resource_record_post_action 02:55:31 INFO - [mozharness: 2017-09-19 09:55:31.110702Z] Finished clobber step (success) 02:55:31 INFO - [mozharness: 2017-09-19 09:55:31.110799Z] Running read-buildbot-config step. 02:55:31 INFO - Running pre-action listener: _resource_record_pre_action 02:55:31 INFO - Running main action method: read_buildbot_config 02:55:31 INFO - Using buildbot properties: 02:55:31 INFO - { 02:55:31 INFO - "project": "", 02:55:31 INFO - "product": "firefox", 02:55:31 INFO - "who": "archaeopteryx@coole-files.de", 02:55:31 INFO - "installer_path": "public/build/target.tar.bz2", 02:55:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:55:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:55:31 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:55:31 INFO - "stage_platform": "linux64-qr", 02:55:31 INFO - "basedir": "/builds/slave/test", 02:55:31 INFO - "buildnumber": 75, 02:55:31 INFO - "platform": "ubuntu64_hw_qr", 02:55:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:55:31 INFO - "slavebuilddir": "test", 02:55:31 INFO - "taskId": "VNusWOwUTRWPaUASQt_0qA", 02:55:31 INFO - "branch": "mozilla-central", 02:55:31 INFO - "script_repo_revision": "production", 02:55:31 INFO - "revision": "7c12af6fd620adc74e9dfb622d17966bdebdf2ac", 02:55:31 INFO - "slavename": "talos-linux64-ix-037", 02:55:31 INFO - "repo_path": "mozilla-central" 02:55:31 INFO - } 02:55:31 INFO - Finding installer, test and symbols from parent task. 02:55:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VNusWOwUTRWPaUASQt_0qA'}, attempt #1 02:55:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VNusWOwUTRWPaUASQt_0qA'}, attempt #1 02:55:31 INFO - Task dependencies: E2iwetAjQBK55x0sv57OwA 02:55:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA'}, attempt #1 02:55:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json 02:55:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip 02:55:32 INFO - Running post-action listener: _resource_record_post_action 02:55:32 INFO - [mozharness: 2017-09-19 09:55:32.437541Z] Finished read-buildbot-config step (success) 02:55:32 INFO - [mozharness: 2017-09-19 09:55:32.437761Z] Running download-and-extract step. 02:55:32 INFO - Running pre-action listener: _resource_record_pre_action 02:55:32 INFO - Running main action method: download_and_extract 02:55:32 INFO - mkdir: /builds/slave/test/build/tests 02:55:32 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')]} 02:55:32 INFO - trying https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json 02:55:32 INFO - Downloading https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:55:32 INFO - Downloaded 989 bytes. 02:55:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:55:32 INFO - Using the following test package requirements: 02:55:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:55:32 INFO - u'common': [u'target.common.tests.zip'], 02:55:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:55:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:55:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:55:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:55:32 INFO - u'mozbase': [u'target.common.tests.zip'], 02:55:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:55:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:55:32 INFO - u'web-platform': [u'target.common.tests.zip', 02:55:32 INFO - u'target.web-platform.tests.tar.gz'], 02:55:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:55:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:55:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip 02:55:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:32 INFO - Fetch https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip into memory 02:55:34 INFO - Content-Length response header: 54731598 02:55:34 INFO - Bytes received: 54731598 02:55:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip 02:55:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:55:45 INFO - Fetch https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip into memory 02:55:46 INFO - Content-Length response header: 14508787 02:55:46 INFO - Bytes received: 14508787 02:55:47 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')]} 02:55:47 INFO - trying https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:47 INFO - Downloading https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:55:50 INFO - Downloaded 61520244 bytes. 02:55:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:50 INFO - mkdir: /builds/slave/test/properties 02:55:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:50 INFO - Contents: 02:55:50 INFO - build_url:https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:50 INFO - Running post-action listener: _resource_record_post_action 02:55:50 INFO - Running post-action listener: find_tests_for_verification 02:55:50 INFO - Running post-action listener: set_extra_try_arguments 02:55:50 INFO - [mozharness: 2017-09-19 09:55:50.111175Z] Finished download-and-extract step (success) 02:55:50 INFO - [mozharness: 2017-09-19 09:55:50.111273Z] Running populate-webroot step. 02:55:50 INFO - Running pre-action listener: _resource_record_pre_action 02:55:50 INFO - Running main action method: populate_webroot 02:55:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['tresize', 02:55:50 INFO - 'tcanvasmark']}, 02:55:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['dromaeo_css', 02:55:50 INFO - 'kraken']}, 02:55:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'tests': ['damp', 'tps']}, 02:55:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['damp', 'tps']}, 02:55:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['dromaeo_dom']}, 02:55:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:55:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['basic_compositor_video', 02:55:50 INFO - 'glvideo']}, 02:55:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['ts_paint_webext', 02:55:50 INFO - 'tp5o_webext']}, 02:55:50 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:50 INFO - 'ts_paint', 02:55:50 INFO - 'tpaint', 02:55:50 INFO - 'sessionrestore', 02:55:50 INFO - 'sessionrestore_many_windows', 02:55:50 INFO - 'sessionrestore_no_auto_restore', 02:55:50 INFO - 'tabpaint']}, 02:55:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['a11yr', 02:55:50 INFO - 'ts_paint', 02:55:50 INFO - 'tpaint', 02:55:50 INFO - 'sessionrestore', 02:55:50 INFO - 'sessionrestore_many_windows', 02:55:50 INFO - 'sessionrestore_no_auto_restore', 02:55:50 INFO - 'tabpaint']}, 02:55:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:55:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:55:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['perf_reftest_singletons']}, 02:55:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['bloom_basic']}, 02:55:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:50 INFO - 'tsvgr_opacity', 02:55:50 INFO - 'tart', 02:55:50 INFO - 'tscrollx', 02:55:50 INFO - 'tsvg_static']}, 02:55:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['tsvgx', 02:55:50 INFO - 'tsvgr_opacity', 02:55:50 INFO - 'tart', 02:55:50 INFO - 'tscrollx', 02:55:50 INFO - 'tsvg_static']}, 02:55:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo'], 02:55:50 INFO - 'tests': ['tp5o']}, 02:55:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:50 INFO - 'talos_options': ['--mitmproxy', 02:55:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:50 INFO - '--firstNonBlankPaint'], 02:55:50 INFO - 'tests': ['tp6_google', 02:55:50 INFO - 'tp6_youtube', 02:55:50 INFO - 'tp6_amazon', 02:55:50 INFO - 'tp6_facebook']}, 02:55:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo', 02:55:50 INFO - '--mitmproxy', 02:55:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:50 INFO - '--firstNonBlankPaint'], 02:55:50 INFO - 'tests': ['tp6_google', 02:55:50 INFO - 'tp6_youtube', 02:55:50 INFO - 'tp6_amazon', 02:55:50 INFO - 'tp6_facebook']}, 02:55:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:50 INFO - 'talos_options': ['--stylo-threads=1', 02:55:50 INFO - '--mitmproxy', 02:55:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:50 INFO - '--firstNonBlankPaint'], 02:55:50 INFO - 'tests': ['tp6_google', 02:55:50 INFO - 'tp6_youtube', 02:55:50 INFO - 'tp6_amazon', 02:55:50 INFO - 'tp6_facebook']}, 02:55:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--xperf_path', 02:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:50 INFO - 'tests': ['tp5n']}, 02:55:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:50 INFO - 'talos_options': ['--disable-stylo', 02:55:50 INFO - '--xperf_path', 02:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:50 INFO - 'tests': ['tp5n']}}} 02:55:50 INFO - Running post-action listener: _resource_record_post_action 02:55:50 INFO - [mozharness: 2017-09-19 09:55:50.126137Z] Finished populate-webroot step (success) 02:55:50 INFO - [mozharness: 2017-09-19 09:55:50.126226Z] Running create-virtualenv step. 02:55:50 INFO - Running pre-action listener: _resource_record_pre_action 02:55:50 INFO - Running main action method: create_virtualenv 02:55:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:55:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:55:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:51 INFO - Installing pip...............done. 02:55:51 INFO - Return code: 0 02:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:51 INFO - Reading from file tmpfile_stdout 02:55:51 INFO - Output received: 02:55:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:55:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:51 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')]} 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:51 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')]} 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:51 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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:51 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 02:55:51 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 02:55:51 INFO - Using env: {'DISPLAY': ':0', 02:55:51 INFO - 'HOME': '/home/cltbld', 02:55:51 INFO - 'LANG': 'en_US.UTF-8', 02:55:51 INFO - 'LANGUAGE': 'en_US:en', 02:55:51 INFO - 'LOGNAME': 'cltbld', 02:55:51 INFO - 'MAIL': '/var/mail/cltbld', 02:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:51 INFO - 'MOZ_NO_REMOTE': '1', 02:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:51 INFO - 'NO_EM_RESTART': '1', 02:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:51 INFO - 'PWD': '/builds/slave/test', 02:55:51 INFO - 'SHELL': '/bin/bash', 02:55:51 INFO - 'SHLVL': '1', 02:55:51 INFO - 'TERM': 'linux', 02:55:51 INFO - 'TMOUT': '86400', 02:55:51 INFO - 'USER': 'cltbld', 02:55:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:51 INFO - '_': '/tools/buildbot/bin/python'} 02:55:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:55:52 INFO - Downloading/unpacking pip>=1.5 02:55:52 INFO - Running setup.py egg_info for package pip 02:55:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:52 INFO - Installing collected packages: pip 02:55:52 INFO - Found existing installation: pip 1.1 02:55:52 INFO - Uninstalling pip: 02:55:52 INFO - Successfully uninstalled pip 02:55:52 INFO - Running setup.py install for pip 02:55:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Successfully installed pip 02:55:52 INFO - Cleaning up... 02:55:52 INFO - Return code: 0 02:55:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:55:52 INFO - Using env: {'DISPLAY': ':0', 02:55:52 INFO - 'HOME': '/home/cltbld', 02:55:52 INFO - 'LANG': 'en_US.UTF-8', 02:55:52 INFO - 'LANGUAGE': 'en_US:en', 02:55:52 INFO - 'LOGNAME': 'cltbld', 02:55:52 INFO - 'MAIL': '/var/mail/cltbld', 02:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:52 INFO - 'MOZ_NO_REMOTE': '1', 02:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:52 INFO - 'NO_EM_RESTART': '1', 02:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:52 INFO - 'PWD': '/builds/slave/test', 02:55:52 INFO - 'SHELL': '/bin/bash', 02:55:52 INFO - 'SHLVL': '1', 02:55:52 INFO - 'TERM': 'linux', 02:55:52 INFO - 'TMOUT': '86400', 02:55:52 INFO - 'USER': 'cltbld', 02:55:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:52 INFO - '_': '/tools/buildbot/bin/python'} 02:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:52 INFO - Downloading/unpacking psutil>=3.1.1 02:55:52 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 02:55:52 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 02:55:52 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 02:55:52 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 02:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:54 INFO - Installing collected packages: psutil 02:55:54 INFO - Running setup.py install for psutil 02:55:54 INFO - building 'psutil._psutil_linux' extension 02:55:54 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 02:55:55 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 02:55:55 INFO - building 'psutil._psutil_posix' extension 02:55:55 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 02:55:55 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 02:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:55 INFO - Successfully installed psutil 02:55:55 INFO - Cleaning up... 02:55:55 INFO - Return code: 0 02:55:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:55:55 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')]} 02:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:55 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')]} 02:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:55 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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:55 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 02:55:55 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 02:55:55 INFO - Using env: {'DISPLAY': ':0', 02:55:55 INFO - 'HOME': '/home/cltbld', 02:55:55 INFO - 'LANG': 'en_US.UTF-8', 02:55:55 INFO - 'LANGUAGE': 'en_US:en', 02:55:55 INFO - 'LOGNAME': 'cltbld', 02:55:55 INFO - 'MAIL': '/var/mail/cltbld', 02:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:55 INFO - 'MOZ_NO_REMOTE': '1', 02:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:55 INFO - 'NO_EM_RESTART': '1', 02:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:55 INFO - 'PWD': '/builds/slave/test', 02:55:55 INFO - 'SHELL': '/bin/bash', 02:55:55 INFO - 'SHLVL': '1', 02:55:55 INFO - 'TERM': 'linux', 02:55:55 INFO - 'TMOUT': '86400', 02:55:55 INFO - 'USER': 'cltbld', 02:55:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:55 INFO - '_': '/tools/buildbot/bin/python'} 02:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:55:57 INFO - Installing collected packages: mozsystemmonitor 02:55:57 INFO - Running setup.py install for mozsystemmonitor 02:55:57 INFO - Successfully installed mozsystemmonitor 02:55:57 INFO - Cleaning up... 02:55:57 INFO - Return code: 0 02:55:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:55:57 INFO - Using env: {'DISPLAY': ':0', 02:55:57 INFO - 'HOME': '/home/cltbld', 02:55:57 INFO - 'LANG': 'en_US.UTF-8', 02:55:57 INFO - 'LANGUAGE': 'en_US:en', 02:55:57 INFO - 'LOGNAME': 'cltbld', 02:55:57 INFO - 'MAIL': '/var/mail/cltbld', 02:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:57 INFO - 'MOZ_NO_REMOTE': '1', 02:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:57 INFO - 'NO_EM_RESTART': '1', 02:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:57 INFO - 'PWD': '/builds/slave/test', 02:55:57 INFO - 'SHELL': '/bin/bash', 02:55:57 INFO - 'SHLVL': '1', 02:55:57 INFO - 'TERM': 'linux', 02:55:57 INFO - 'TMOUT': '86400', 02:55:57 INFO - 'USER': 'cltbld', 02:55:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:57 INFO - '_': '/tools/buildbot/bin/python'} 02:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:58 INFO - warning: no files found matching '*.txt' 02:55:58 INFO - no previously-included directories found matching 'build' 02:55:58 INFO - no previously-included directories found matching 'dist' 02:55:58 INFO - no previously-included directories found matching '.git*' 02:55:58 INFO - Installing collected packages: jsonschema, functools32 02:55:59 INFO - Running setup.py install for functools32 02:55:59 INFO - warning: no files found matching '*.txt' 02:55:59 INFO - no previously-included directories found matching 'build' 02:55:59 INFO - no previously-included directories found matching 'dist' 02:55:59 INFO - no previously-included directories found matching '.git*' 02:55:59 INFO - Successfully installed jsonschema functools32 02:55:59 INFO - Cleaning up... 02:55:59 INFO - Return code: 0 02:55:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:55:59 INFO - Using env: {'DISPLAY': ':0', 02:55:59 INFO - 'HOME': '/home/cltbld', 02:55:59 INFO - 'LANG': 'en_US.UTF-8', 02:55:59 INFO - 'LANGUAGE': 'en_US:en', 02:55:59 INFO - 'LOGNAME': 'cltbld', 02:55:59 INFO - 'MAIL': '/var/mail/cltbld', 02:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:59 INFO - 'MOZ_NO_REMOTE': '1', 02:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:59 INFO - 'NO_EM_RESTART': '1', 02:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:59 INFO - 'PWD': '/builds/slave/test', 02:55:59 INFO - 'SHELL': '/bin/bash', 02:55:59 INFO - 'SHLVL': '1', 02:55:59 INFO - 'TERM': 'linux', 02:55:59 INFO - 'TMOUT': '86400', 02:55:59 INFO - 'USER': 'cltbld', 02:55:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:59 INFO - '_': '/tools/buildbot/bin/python'} 02:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:55:59 INFO - Cleaning up... 02:55:59 INFO - Return code: 0 02:55:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:59 INFO - Using env: {'DISPLAY': ':0', 02:55:59 INFO - 'HOME': '/home/cltbld', 02:55:59 INFO - 'LANG': 'en_US.UTF-8', 02:55:59 INFO - 'LANGUAGE': 'en_US:en', 02:55:59 INFO - 'LOGNAME': 'cltbld', 02:55:59 INFO - 'MAIL': '/var/mail/cltbld', 02:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:59 INFO - 'MOZ_NO_REMOTE': '1', 02:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:59 INFO - 'NO_EM_RESTART': '1', 02:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:59 INFO - 'PWD': '/builds/slave/test', 02:55:59 INFO - 'SHELL': '/bin/bash', 02:55:59 INFO - 'SHLVL': '1', 02:55:59 INFO - 'TERM': 'linux', 02:55:59 INFO - 'TMOUT': '86400', 02:55:59 INFO - 'USER': 'cltbld', 02:55:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:59 INFO - '_': '/tools/buildbot/bin/python'} 02:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:01 INFO - Downloading docopt-0.6.1.tar.gz 02:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:01 INFO - Running setup.py install for blobuploader 02:56:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:01 INFO - Running setup.py install for requests 02:56:01 INFO - Running setup.py install for docopt 02:56:01 INFO - Successfully installed blobuploader requests docopt 02:56:01 INFO - Cleaning up... 02:56:01 INFO - Return code: 0 02:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:01 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 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:56:01 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 02:56:01 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 02:56:01 INFO - Using env: {'DISPLAY': ':0', 02:56:01 INFO - 'HOME': '/home/cltbld', 02:56:01 INFO - 'LANG': 'en_US.UTF-8', 02:56:01 INFO - 'LANGUAGE': 'en_US:en', 02:56:01 INFO - 'LOGNAME': 'cltbld', 02:56:01 INFO - 'MAIL': '/var/mail/cltbld', 02:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:01 INFO - 'MOZ_NO_REMOTE': '1', 02:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:01 INFO - 'NO_EM_RESTART': '1', 02:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:01 INFO - 'PWD': '/builds/slave/test', 02:56:01 INFO - 'SHELL': '/bin/bash', 02:56:01 INFO - 'SHLVL': '1', 02:56:01 INFO - 'TERM': 'linux', 02:56:01 INFO - 'TMOUT': '86400', 02:56:01 INFO - 'USER': 'cltbld', 02:56:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:01 INFO - '_': '/tools/buildbot/bin/python'} 02:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:02 INFO - Running setup.py (path:/tmp/pip-7orzfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:02 INFO - Running setup.py (path:/tmp/pip-3aUBMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:02 INFO - Running setup.py (path:/tmp/pip-4uZzop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:02 INFO - Running setup.py (path:/tmp/pip-TlDtU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:02 INFO - Running setup.py (path:/tmp/pip-nmtcmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:02 INFO - Running setup.py (path:/tmp/pip-8MrbIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:02 INFO - Running setup.py (path:/tmp/pip-ZZjUkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:02 INFO - Running setup.py (path:/tmp/pip-PJaOjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:02 INFO - Running setup.py (path:/tmp/pip-aXzQun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:02 INFO - Running setup.py (path:/tmp/pip-xwFOEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:02 INFO - Running setup.py (path:/tmp/pip-Jyycbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:02 INFO - Running setup.py (path:/tmp/pip-6JkDhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:03 INFO - Running setup.py (path:/tmp/pip-tNaBiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:03 INFO - Running setup.py (path:/tmp/pip-yfZiba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:03 INFO - Running setup.py (path:/tmp/pip-dMps1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:03 INFO - Running setup.py (path:/tmp/pip-y8TQB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:03 INFO - Running setup.py (path:/tmp/pip-0J9gF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:03 INFO - Running setup.py install for manifestparser 02:56:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozcrash 02:56:03 INFO - Running setup.py install for mozdebug 02:56:03 INFO - Running setup.py install for mozdevice 02:56:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozfile 02:56:03 INFO - Running setup.py install for mozhttpd 02:56:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozinfo 02:56:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for mozInstall 02:56:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for mozleak 02:56:04 INFO - Running setup.py install for mozlog 02:56:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for moznetwork 02:56:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for mozprocess 02:56:04 INFO - Running setup.py install for mozprofile 02:56:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for mozrunner 02:56:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Running setup.py install for mozscreenshot 02:56:04 INFO - Running setup.py install for moztest 02:56:04 INFO - Running setup.py install for mozversion 02:56:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:05 INFO - Cleaning up... 02:56:05 INFO - Return code: 0 02:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:05 INFO - Using env: {'DISPLAY': ':0', 02:56:05 INFO - 'HOME': '/home/cltbld', 02:56:05 INFO - 'LANG': 'en_US.UTF-8', 02:56:05 INFO - 'LANGUAGE': 'en_US:en', 02:56:05 INFO - 'LOGNAME': 'cltbld', 02:56:05 INFO - 'MAIL': '/var/mail/cltbld', 02:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:05 INFO - 'MOZ_NO_REMOTE': '1', 02:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:05 INFO - 'NO_EM_RESTART': '1', 02:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:05 INFO - 'PWD': '/builds/slave/test', 02:56:05 INFO - 'SHELL': '/bin/bash', 02:56:05 INFO - 'SHLVL': '1', 02:56:05 INFO - 'TERM': 'linux', 02:56:05 INFO - 'TMOUT': '86400', 02:56:05 INFO - 'USER': 'cltbld', 02:56:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:05 INFO - '_': '/tools/buildbot/bin/python'} 02:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:05 INFO - Running setup.py (path:/tmp/pip-ciWHdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:05 INFO - Running setup.py (path:/tmp/pip-yQGZ15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:05 INFO - Running setup.py (path:/tmp/pip-hbR8mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:05 INFO - Running setup.py (path:/tmp/pip-tyURC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:05 INFO - Running setup.py (path:/tmp/pip-ryDyYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:05 INFO - Running setup.py (path:/tmp/pip-nWhpmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:05 INFO - Running setup.py (path:/tmp/pip-KZUyvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:05 INFO - Running setup.py (path:/tmp/pip-B6npte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:05 INFO - Running setup.py (path:/tmp/pip-xiZrcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:05 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:05 INFO - Running setup.py (path:/tmp/pip-Cch7hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:06 INFO - Running setup.py (path:/tmp/pip-EMJnj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:06 INFO - Running setup.py (path:/tmp/pip-UVZpqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:06 INFO - Running setup.py (path:/tmp/pip-harnDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:06 INFO - Running setup.py (path:/tmp/pip-x0Gawp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:06 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)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:06 INFO - Running setup.py (path:/tmp/pip-uKyd6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:06 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)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:06 INFO - Running setup.py (path:/tmp/pip-xoCC2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:06 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)) 02:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:06 INFO - Running setup.py (path:/tmp/pip-g1m0MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:06 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)) 02:56:06 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)) 02:56:06 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)) 02:56:06 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)) 02:56:06 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)) 02:56:06 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)) 02:56:06 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)) 02:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:06 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 02:56:06 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 02:56:06 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 02:56:06 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 02:56:07 INFO - Downloading blessings-1.6.tar.gz 02:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:07 INFO - Installing collected packages: blessings 02:56:07 INFO - Running setup.py install for blessings 02:56:07 INFO - Successfully installed blessings 02:56:07 INFO - Cleaning up... 02:56:07 INFO - Return code: 0 02:56:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:08 INFO - Reading from file tmpfile_stdout 02:56:08 INFO - Current package versions: 02:56:08 INFO - argparse == 1.2.1 02:56:08 INFO - blessings == 1.6 02:56:08 INFO - blobuploader == 1.2.4 02:56:08 INFO - docopt == 0.6.1 02:56:08 INFO - functools32 == 3.2.3-2 02:56:08 INFO - jsonschema == 2.5.1 02:56:08 INFO - manifestparser == 1.1 02:56:08 INFO - mozInstall == 1.13 02:56:08 INFO - mozcrash == 1.0 02:56:08 INFO - mozdebug == 0.1 02:56:08 INFO - mozdevice == 0.51 02:56:08 INFO - mozfile == 1.2 02:56:08 INFO - mozhttpd == 0.7 02:56:08 INFO - mozinfo == 0.10 02:56:08 INFO - mozleak == 0.1 02:56:08 INFO - mozlog == 3.5 02:56:08 INFO - moznetwork == 0.27 02:56:08 INFO - mozprocess == 0.25 02:56:08 INFO - mozprofile == 0.28 02:56:08 INFO - mozrunner == 6.13 02:56:08 INFO - mozscreenshot == 0.1 02:56:08 INFO - mozsystemmonitor == 0.3 02:56:08 INFO - moztest == 0.8 02:56:08 INFO - mozversion == 1.4 02:56:08 INFO - psutil == 3.1.1 02:56:08 INFO - requests == 1.2.3 02:56:08 INFO - wsgiref == 0.1.2 02:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:08 INFO - Using env: {'DISPLAY': ':0', 02:56:08 INFO - 'HOME': '/home/cltbld', 02:56:08 INFO - 'LANG': 'en_US.UTF-8', 02:56:08 INFO - 'LANGUAGE': 'en_US:en', 02:56:08 INFO - 'LOGNAME': 'cltbld', 02:56:08 INFO - 'MAIL': '/var/mail/cltbld', 02:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:08 INFO - 'MOZ_NO_REMOTE': '1', 02:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:08 INFO - 'NO_EM_RESTART': '1', 02:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:08 INFO - 'PWD': '/builds/slave/test', 02:56:08 INFO - 'SHELL': '/bin/bash', 02:56:08 INFO - 'SHLVL': '1', 02:56:08 INFO - 'TERM': 'linux', 02:56:08 INFO - 'TMOUT': '86400', 02:56:08 INFO - 'USER': 'cltbld', 02:56:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:08 INFO - '_': '/tools/buildbot/bin/python'} 02:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 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)) 02:56:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:56:09 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)) 02:56:09 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)) 02:56:09 INFO - Installing collected packages: simplejson 02:56:09 INFO - Running setup.py install for simplejson 02:56:09 INFO - building 'simplejson._speedups' extension 02:56:09 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 02:56:10 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 02:56:10 INFO - Successfully installed simplejson 02:56:10 INFO - Cleaning up... 02:56:10 INFO - Return code: 0 02:56:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', '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 02:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:56:10 INFO - Using env: {'DISPLAY': ':0', 02:56:10 INFO - 'HOME': '/home/cltbld', 02:56:10 INFO - 'LANG': 'en_US.UTF-8', 02:56:10 INFO - 'LANGUAGE': 'en_US:en', 02:56:10 INFO - 'LOGNAME': 'cltbld', 02:56:10 INFO - 'MAIL': '/var/mail/cltbld', 02:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:10 INFO - 'MOZ_NO_REMOTE': '1', 02:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:10 INFO - 'NO_EM_RESTART': '1', 02:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:10 INFO - 'PWD': '/builds/slave/test', 02:56:10 INFO - 'SHELL': '/bin/bash', 02:56:10 INFO - 'SHLVL': '1', 02:56:10 INFO - 'TERM': 'linux', 02:56:10 INFO - 'TMOUT': '86400', 02:56:10 INFO - 'USER': 'cltbld', 02:56:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:10 INFO - '_': '/tools/buildbot/bin/python'} 02:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:10 INFO - Cleaning up... 02:56:10 INFO - Return code: 0 02:56:10 INFO - Running post-action listener: _resource_record_post_action 02:56:10 INFO - Running post-action listener: _start_resource_monitoring 02:56:10 INFO - Starting resource monitoring. 02:56:10 INFO - [mozharness: 2017-09-19 09:56:10.820550Z] Finished create-virtualenv step (success) 02:56:10 INFO - [mozharness: 2017-09-19 09:56:10.821591Z] Running install step. 02:56:10 INFO - Running pre-action listener: _resource_record_pre_action 02:56:10 INFO - Running main action method: install 02:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:11 INFO - Reading from file tmpfile_stdout 02:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:11 INFO - Reading from file tmpfile_stdout 02:56:11 INFO - Output received: 02:56:11 INFO - Usage: mozinstall [options] installer 02:56:11 INFO - Options: 02:56:11 INFO - -h, --help show this help message and exit 02:56:11 INFO - -d DEST, --destination=DEST 02:56:11 INFO - Directory to install application into. [default: 02:56:11 INFO - "/builds/slave/test"] 02:56:11 INFO - --app=APP Application being installed. [default: firefox] 02:56:11 INFO - mkdir: /builds/slave/test/build/application 02:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:56:28 INFO - Reading from file tmpfile_stdout 02:56:28 INFO - Output received: 02:56:28 INFO - /builds/slave/test/build/application/firefox/firefox 02:56:28 INFO - Running post-action listener: _resource_record_post_action 02:56:28 INFO - [mozharness: 2017-09-19 09:56:28.972566Z] Finished install step (success) 02:56:28 INFO - [mozharness: 2017-09-19 09:56:28.972713Z] Running setup-mitmproxy step. 02:56:28 INFO - Running pre-action listener: _resource_record_pre_action 02:56:28 INFO - Running main action method: setup_mitmproxy 02:56:28 INFO - Skipping: mitmproxy is not required 02:56:28 INFO - Running post-action listener: _resource_record_post_action 02:56:28 INFO - [mozharness: 2017-09-19 09:56:28.973237Z] Finished setup-mitmproxy step (success) 02:56:28 INFO - [mozharness: 2017-09-19 09:56:28.973341Z] Running run-tests step. 02:56:28 INFO - Running pre-action listener: _resource_record_pre_action 02:56:28 INFO - Running pre-action listener: _set_gcov_prefix 02:56:28 INFO - Running main action method: run_tests 02:56:28 WARNING - Try message not found. 02:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:28 INFO - Python 2.7.3 02:56:28 INFO - Return code: 0 02:56:28 INFO - grabbing minidump binary from tooltool 02:56: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')]} 02:56:28 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 0x18e2090>, '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 0x18e2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:28 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 02:56:28 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 02:56:28 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 02:56:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:29 INFO - Return code: 0 02:56:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:56:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:29 INFO - ENV: RUST_BACKTRACE is now full 02:56:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:56:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 02:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 02:56:29 INFO - Using env: {'DISPLAY': ':0', 02:56:29 INFO - 'HOME': '/home/cltbld', 02:56:29 INFO - 'LANG': 'en_US.UTF-8', 02:56:29 INFO - 'LANGUAGE': 'en_US:en', 02:56:29 INFO - 'LOGNAME': 'cltbld', 02:56:29 INFO - 'MAIL': '/var/mail/cltbld', 02:56:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:29 INFO - 'MOZ_ACCELERATED': '1', 02:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:29 INFO - 'MOZ_NO_REMOTE': '1', 02:56:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:29 INFO - 'MOZ_WEBRENDER': '1', 02:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:29 INFO - 'NO_EM_RESTART': '1', 02:56:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:29 INFO - 'PWD': '/builds/slave/test', 02:56:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:29 INFO - 'RUST_BACKTRACE': 'full', 02:56:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:29 INFO - 'SHELL': '/bin/bash', 02:56:29 INFO - 'SHLVL': '1', 02:56:29 INFO - 'TERM': 'linux', 02:56:29 INFO - 'TMOUT': '86400', 02:56:29 INFO - 'USER': 'cltbld', 02:56:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:29 INFO - '_': '/tools/buildbot/bin/python'} 02:56:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 02:56:29 INFO - mozversion application_buildid: 20170919090857 02:56:29 INFO - mozversion application_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 02:56:29 INFO - mozversion application_display_name: Nightly 02:56:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:29 INFO - mozversion application_name: Firefox 02:56:29 INFO - mozversion application_remotingname: firefox 02:56:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:29 INFO - mozversion application_vendor: Mozilla 02:56:29 INFO - mozversion application_version: 57.0a1 02:56:29 INFO - mozversion platform_buildid: 20170919090857 02:56:29 INFO - mozversion platform_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 02:56:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:29 INFO - mozversion platform_version: 57.0a1 02:56:29 INFO - using testdate: 1505814989 02:56:29 INFO - actual date: 1505814989 02:56:29 INFO - starting webserver on 'localhost:51852' 02:56:29 INFO - SUITE-START | Running 2 tests 02:56:29 INFO - TEST-START | dromaeo_css 02:56:29 INFO - Initialising browser for dromaeo_css test... 02:56:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51852/getInfo.html -profile /tmp/tmpEz_wqy/profile 02:56:29 INFO - TEST-INFO | started process 3565 (/builds/slave/test/build/application/firefox/firefox http://localhost:51852/getInfo.html) 02:56:39 INFO - TEST-INFO | 3565: exit 0 02:56:39 INFO - Browser initialized. 02:56:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:39 INFO - Using env: {'DISPLAY': ':0', 02:56:39 INFO - 'HOME': '/home/cltbld', 02:56:39 INFO - 'JSGC_DISABLE_POISONING': '1', 02:56:39 INFO - 'LANG': 'en_US.UTF-8', 02:56:39 INFO - 'LANGUAGE': 'en_US:en', 02:56:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:56:39 INFO - 'LOGNAME': 'cltbld', 02:56:39 INFO - 'MAIL': '/var/mail/cltbld', 02:56:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:39 INFO - 'MOZ_ACCELERATED': '1', 02:56:39 INFO - 'MOZ_CRASHREPORTER': '1', 02:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:56:39 INFO - 'MOZ_NO_REMOTE': '1', 02:56:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:39 INFO - 'MOZ_WEBRENDER': '1', 02:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:39 INFO - 'NO_EM_RESTART': '1', 02:56:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:39 INFO - 'PWD': '/builds/slave/test', 02:56:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:39 INFO - 'RUST_BACKTRACE': 'full', 02:56:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:39 INFO - 'SHELL': '/bin/bash', 02:56:39 INFO - 'SHLVL': '1', 02:56:39 INFO - 'TERM': 'linux', 02:56:39 INFO - 'TMOUT': '86400', 02:56:39 INFO - 'USER': 'cltbld', 02:56:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 02:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:39 INFO - '_': '/tools/buildbot/bin/python'} 02:56:39 INFO - TEST-INFO | started process 3804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEz_wqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:40 INFO - PID 3804 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:56:41 INFO - PID 3804 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:56:41 INFO - PID 3804 | 02:56:41 INFO - PID 3804 | (/builds/slave/test/build/application/firefox/firefox:3863): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:56:41 INFO - PID 3804 | 02:56:51 INFO - PID 3804 | RSS: Main: 203194368 02:56:51 INFO - PID 3804 | 02:59:48 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51852/tests/dromaeo/cssquery-ext.html) 02:59:49 INFO - PID 3804 | RSS: Main: 207556608 02:59:49 INFO - PID 3804 | 03:02:51 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-ext.html (next: http://localhost:51852/tests/dromaeo/cssquery-jquery.html) 03:02:52 INFO - PID 3804 | RSS: Main: 205520896 03:02:52 INFO - PID 3804 | 03:05:54 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51852/tests/dromaeo/cssquery-mootools.html) 03:05:55 INFO - PID 3804 | RSS: Main: 207470592 03:05:55 INFO - PID 3804 | 03:08:57 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51852/tests/dromaeo/cssquery-prototype.html) 03:08:57 INFO - PID 3804 | RSS: Main: 206663680 03:08:57 INFO - PID 3804 | 03:12:01 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51852/tests/dromaeo/cssquery-yui.html) 03:12:01 INFO - PID 3804 | RSS: Main: 207892480 03:12:01 INFO - PID 3804 | 03:15:03 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:51852/tests/dromaeo/cssquery-yui.html (next: http://localhost:51852/tests/dromaeo/cssquery-dojo.html) 03:15:04 INFO - PID 3804 | RSS: Main: 210493440 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | __start_tp_report 03:15:04 INFO - PID 3804 | _x_x_mozilla_page_load 03:15:04 INFO - PID 3804 | _x_x_mozilla_page_load_details 03:15:04 INFO - PID 3804 | |i|pagename|runs| 03:15:04 INFO - PID 3804 | |0;dojo.html;3078.6459557150934;3108.8601012954414;3128.1241252449313;3130.499120140778;3139.4035133324664;6073.878522429549;6242.906356404652;6277.246730392348;6298.307186209513;6308.1799366082405;6164.167837341957;6207.937920620792;6208.751649933997;6219.284782250032;6228.22147231596;5665.433456654343;5668.744906479208;5701.059325211335;5783.82648520543;5835.095560188178;5788.536917046647;5813.6221145625395;5831.970840145815;5833.008388573952;5877.6473411595225;80.92326345065315;5671.177679236487;5737.598368114233;5864.560157988168;5895.469407753301;5313.38896026958;5684.459976302244;5765.1928729977835;5833.7083145842535;5836.182934389147;5645.8588535286535;5746.683932383718;5800.419958004166;5804.970975145139;5820.941790582125;6221.782237621706;6234.064890266451;6273.278572964076;6299.6850157491945;6350.396712312323;6656.833579160511;6695.430888374494;6695.531312808105;6765.05289259504;6778.932210677879;6523.7716679915975;6737.393634572912;6766.932330676679;6817.693203805791;6865.9313406865795;6154.815355539341;6161.075838624242;6192.318844927055;6301.779437719703;6311.179546658951;6921.307869213038;6945.756898508528;6967.477439192081;7011.474139439562;7017.333353331425;6499.122618446449;6600.405963463311;6621.668916554249;6658.300878407795;6660.600363978177;6387.808365749035;6689.1972963244725;6725.529212955046;6787.490938179656;6819.863602728017;6501.349865013555;6505.544611877123;6532.477401807844;6565.967170164118;6580.901286480706;6494.9350506495275;6581.3418658133805;6583.506237032242;6588.8023359299295;6606.86786264272;5237.973810131001;5309.7079660618265;5328.254044433782;5333.066713325153;5334.839954801362;4514.841980530731;4521.299198624219;4569.223232050559;4644.512326205768;4659.068186362741;5680.375158732536;5747.39652336507;5752.223449834302;5754.539636829044;5761.827145185651;6666.333366663392;6667.366600173073;6691.297413771581;6747.932520674731;6748.122744043243;5542.307211598551;5608.130739735348;5617.662940223599;5651.773929042793;5727.742251598688;5644.125160600031;5690.9146362804595;5692.943070569241;5698.344690360662;5705.115707065412;6364.172657554488;6445.387688169616;6552.63960482178;6553.475721942328;6561.606303621798;6686.96656516724;6707.429868461236;6721.529492935448;6792.08306878575;6844.863102737818;6388.584741991755;6473.805785826433;6494.318096599789;6576.145101136822;6579.671016449254;6426.068220108152;6506.837329066622;6563.704633291609;6583;6674.132362792806;6576.177977752781;6614.70233839488;6615.338466153346;6631.237407698177;6633.2040155181685;6438.645874476949;6456;6461.903071453838;6489.448396886318;6514.185726784152;6446.8388290293115;6553.934460655332;6572.8356791080605;6573.934260657332;6583.473322134314;6414.262359828679;6418.743250270124;6445.291017988111;6490.902636460362;6508.153939987771;6309.400606942333;6499.122618446639;6512.120863683532;6548.672566371758;6592.208934927839;6355.586886852339;6364.427201551883;6373.840653983688;6386.074019267087;6394.616323020447 03:15:04 INFO - PID 3804 | |1;ext.html;835.7994081420461;851.3487182305533;884.4914174349749;899.8920129584455;911.084360217981;39343.60656393435;40243;40357;40357.394639080434;40407.797961010154;36928.44607330892;37149.62850371496;37163.81418092906;37247.627523724754;37369;6986.930130698692;7089.468289878279;7109.8933515997305;7140.821479463003;7178.246284140168;7036.226015138331;7078.716851325941;7082.893756593655;7098.503104782667;7130.786076417716;7097.183823860245;7134.286571342876;7217.242189570098;7994.160613135624;8031.718889838857;7900.170482099383;7900.80247993799;7992.080910695287;7994.64024118916;7999.400044996649;7818.530888146673;7873.330766884765;7895.960520197362;7903.288704016666;7905.644246008886;37350.25299494022;38072.23855522874;38182.42726359107;38318.42522362139;38407.42388864169;3548.822558872046;3553.8045407502577;3559.4482855157494;3580.677739003502;3592.838322275478;31053.84473077643;31070.689293107007;31109.37781244385;31154.221144471343;31321.8433907829;5122.436531981479;5152.5105115014385;5156.407013193493;5167.612429067797;5204.791808327663;183489;185364;185423.07288463606;185436;185499;46890.5310946893;46989.53010469852;47116.5288347119;47195.52804471911;47335;49010.75494622575;49055.26417103747;49098;49265.75367123142;49377.259341109915;15593.532194034196;15780.447684330993;15895.68208635844;15901.363945442285;15918.840811591968;12926.67683307906;12940.870591294155;12964;12977.35113244334;13047.739045219043;13678.589642310746;13753.243571603658;13886.166829990232;13953.093048951785;14115.929420353037;5763.538916886639;5765.336986246635;5770.624909380961;5916.615419997773;5974.133750606138;1034.3276870034538;1034.4724190662816;1042.5985995391677;1045.513836066233;1057.9682609521574;22890.771092289197;23008.309750707507;23017.309480715605;23053.423664408525;23065.19271825478;1126.707056165403;1130.496928866663;1146.2549342926998;1151.5336288803048;1154.6766905266538;11998.760024799456;12033.518659253707;12335.814962775565;12392.504299827906;12443.751124977449;210022;210215;211137;211651;212741;42554.57445425568;42731.57268427338;49637.25544116841;49807.501924981014;50125.24812127821;1459.4454107439317;1484.050207866966;1484.6807936293749;1487.152323175801;1487.9404823807142;27404.725952740217;27716.566866267465;27927.022554210504;27985.720142798313;28081.57877631878;37135.25729485449;37794.24411511809;37858.43212351872;37941.62058379381;38019.80990095032;202157;202383;203819;203913;204569;34439.65560344465;35208.823955880056;35223.64776352306;35338.293234135686;35908.64091359053;42906;43108;43182.56817431786;43295.56704432915;43552.56447435612;29933.55099673463;31779.36441271208;31949.68050319467;32436.83781581077;32845.17887052843;31201.53197701991;31345.686543134278;31701.207469812518;31830;31893.8405307972;33799;34627.4805877907;35093.29813403769;35258.8237058813;35797;31147;31317.686823131477;31571;31667.84166079155;31724.206894827814;23335.649965250876;23421.88289058544;23567.17514886971;23911.28266152018;24079 03:15:04 INFO - PID 3804 | |2;jquery.html;577.8873119741652;578.6094386289253;580.4978693430181;584.5937073733754;591.1044767177726;21882.89058554709;22623;22640.43398915028;22668.09327626893;22668.09327626897;23863.64204536933;24344.51310973784;24889.875550622266;24900.875495622495;25178.622320665203;6415.454686351654;6479.578827376229;6552.672366381686;6556.704948277339;6558.639274839906;6144.139820425144;6421.8715625687455;6504.70728817202;6527.41253287204;6532.542722009462;6397.136386587821;6413.647249401281;6433.93566064338;6454.9677251613675;6464.3212462691445;6442.259140198867;6459.741610335581;6467.385598368194;6474.5791523550815;6482.060101285334;5832.096025116114;5986.970065149646;5993.9400605993815;6007.219061521974;6087.969560152215;27152.32119197016;27275.45449091007;27669.169924902286;27738;27748;1985.463924740312;2001.0695026812457;2003.5692326149947;2013.2953466286683;2019.1822311963679;18262.452126436227;18770;19077.236910523563;19121.330753423703;19131.13909874059;2325.209428794218;2393.9162129325564;2413.9517209655883;2428.659987601737;2438.317271164077;120424;124528.37735811353;125260.37369813184;137037;141403.29298353443;19432.514187145436;20158.69761953572;20282.492937676678;20540.84321146288;21504.677429838564;39263.41104883429;39681;39744;39747;39833.40249896254;11172;11256.718582035515;11400.486978086006;11416.31502109876;11497;9342.532873356306;9549.379290346244;9565.426074435556;9598.472084035306;9698.175655069399;10345;10890.945545272381;11004;11052.889471105347;11119.944400277947;4093.488313960755;4103.712740108163;4130.690198235085;4258.190943720683;4281.709285532225;940.8400571902793;946.926231552897;966.5602151021268;972.2367941166151;978.8580655804868;18417.907910460362;18710.158042888103;18867.90566047161;18981.810181898003;19044.52388690266;1013.2906965124295;1026.6765968719828;1032.1072272484398;1034.632705389576;1035.4201647077662;10375.429351385596;10450.634227801991;10628.41543715103;10790.946045269724;10860.945695271632;440692;442692;454429;455981;456317;111111.44444277727;113738;114265;114889.4255528717;117164.41417792857;1160.878107798686;1170.169179882293;1176.7705297467082;1205.8854408831146;1213.0841214882882;16879.87706308476;16916.915415422845;16918.32326706918;16921.915390423463;17038.233279502205;56126.43873561212;56196;56221.43778562325;56473.43526564682;57805.710971444874;68765.3123468779;68930;69591.3040869605;70017;70094.29905700877;18401.53996150107;18847.434576962714;18879.244830206637;18908.621827563646;19265.13306901165;21004.47488812792;21381.572368552854;21553.35339939804;21640.350789476342;21668.566628667653;17341.73987390165;17500.037497937734;17528.649427011642;17636.20637071309;17643.29426822964;15050.924745376204;15682.529524114294;16265.268062936959;16282.348706051625;16519.421820236235;17638.38265660696;17983.280668773103;17992.640147197246;18081.457556273333;18305.450836474927;18015.099245037956;18165.909170454594;18247.087645617932;18266.26934922588;18366;16868.493945181664;17441.825581744528;17470.03914784699;17500.299988000846;17678.911605441892 03:15:04 INFO - PID 3804 | |3;mootools.html;1301.882830545251;1396.6089494941407;1400.4118270326464;1408.4295860176626;1408.4929425406851;15512.224388780558;15848.445304414334;15848.603784905368;15936.362545498167;15968.920155399235;15583.142927139002;15753.369865205406;15796.131212783292;15836.920815395935;15847.207639618031;2711.4441539484455;2768.9446211075815;2786.8467234302107;2794.9021784237557;2800.313923088846;2691.5155272051024;2734.86325683716;2743.1496236166754;2745.1078399520234;2752;2621.5281249375107;2658.710525395182;2674.6790385153713;2714.1043455659583;2750.2711781377952;2668.559687651535;2677.7723893468983;2712.0643378034647;2713.8778754956074;2725.604787305849;2643.788496920242;2648.973510264892;2660.521106200883;2678.745519175695;2679.2498100531884;14531.564053078424;14870.851291487163;14894.70210595782;14908.62728431787;14921.776173357408;8067.959660201662;8310.127436619128;8342.874856877152;8353.289970352527;8371.204735550113;5137.897242055175;5289.471052894718;5317.893642127175;5346.946530534684;5376.596755243333;1953.8827670339824;1963.862529622927;1991.6813309870352;2031.7561892572985;2037.0629510425074;26822.195334140008;26836.194914152606;27045.594316085273;27307.590386144224;27611.171664850088;6834.086455792386;6949;7105.573665580082;7208.819779505554;7217.8556428871125;17333.7399939001;17399.826001740075;17416.04211768365;17540.736888946674;17598.12009399525;7764.961175194087;7810.765677029698;7914.881276780853;7924.247196516321;7927.207279272142;7253.673584688701;7273.8545229095125;7293.671784769698;7318.451116166202;7420.628968551551;5203.401608814959;5367.275417818544;5386.48828361305;5397.217403476474;5407.513323800877;1509;1513.5459362191298;1532.6551525906582;1533.3866453418723;1535.4088675859875;848.1391387741447;853.108501615813;862.2584577263548;866.4931015355961;879.9076097009722;7133.8929916050265;7170.067891174114;7192.82017949545;7231.927680723231;7249.710011599583;664.5049438168595;695.488815720445;703.641143017065;704.8378872859271;730.649288341599;4188.581141885848;4229.577042295746;4249.68127390447;4278.080212754273;4726.338312636233;21215.257465988616;21548.4612884676;21859.234926777488;22006.339809805733;22039.228626997978;20442.897785510977;21494.14023439076;21843.235486757887;21863.672044919338;22092.447688807588;10672.733181670521;10805.891941080488;10821.891781082088;10968.23222374426;11428.971392574707;7671.53970761756;8132;8184.345252379914;8222.301104405953;8237.670493180205;18916.243350265835;18923.90538047301;19010.23959041623;19190.232390704776;19214.423567293004;18490.722639160154;19024.1439135242;19426.611467770847;19468.221271148996;19477.51306217356;10923.890761092605;10951.069159121564;11012.5044373005;11021.173411993972;11039.668809935714;13782.241976691379;14064.437422502986;14156.575302740934;14158.292085395895;14233.64415889611;11548.307101573933;11666.941665291619;11993.220440671328;12050.879491204976;12129.272243665408;11255.437228138397;11279.943600281946;11347.829782553103;11458.484368203617;11585.189036767346;9750.219982401533;9848.606055757977;9932;9932;9932.751681208028;7291.234420385996;7301.415886729155;7302.488825782144;7335.046443962464;7401.555906645618;7284.854302913806;7315.341619254293;7330.450216233698;7418.517796343221;7443.590602516913 03:15:04 INFO - PID 3804 | |4;prototype.html;495.98946022397035;497.61641736084147;515.6570880364558;518.7613697699059;531.2111514401114;6109.633421994683;6162.168107305512;6170.382961703827;6174.135621013056;6237.906431403521;6051.697415129237;6075.422834830695;6094.481969032627;6160.322364539897;6182.7217775200115;5053.4946505349535;5121.3342265505435;5125.666831655949;5127.487251274862;5134.306868572732;5138.7173705446185;5166.509181627758;5187.974060129713;5218.921716174261;5222.738863056832;4733.928991065137;4927.556519913207;4935.605151587864;4948.158813001798;4971.179755340365;4910.435299940481;4912.214045752698;4942.752862356886;4965.155923492996;4967.410428662829;4339.934900976488;4392.560743925614;4395.670324725626;4414.095110502371;4417.734935903856;5982.670953097578;6028.005379112485;6049.153118563405;6063.9090413643835;6093.817185484442;5584.636998595079;5597.74810133545;5625.578081643852;5671.120976248688;5682.374938756733;6358.1416508771645;6374.936250637481;6450.258220304631;6474.1907261592305;6532.268948728591;4571.291449825282;4822.831200907986;4853.781579828917;4888.169011268093;4897.975510122462;6609.834754131137;6689.23073846509;6748.797536073926;6796.592204467748;6842.931570684279;4898.730569818623;4911.87720306988;4951.529604687549;4959.578435832923;5005.34930459038;4957.429895561984;4984.725840078758;5005.449400565934;5044.319016932667;5048.192289233705;5605.971970140124;5645.294338207724;5652;5658.321001479849;5675.687837168913;6420.775272865428;6500.414962653289;6543.738250469928;6545.738170473128;6555.1478307820635;1693.6612677464557;1721.397510871185;1724.7499112628598;1741.5907261793468;1743.4420985284587;1113.287496002559;1191.6961174900346;1199.7780410624061;1219.8475190601175;1231.2858542045592;5507.925954438846;5546.667199968015;5591.8881622368135;5624.55003599711;5635.971820140873;6471.708773105222;6477.384648458389;6550.460641749185;6565.21217453899;6590.604563726191;5537.833864984057;5539.756398658469;5546.889062218733;5557.527255277355;5568.1091025435735;3405.9489107663403;3431.571053618298;3470.9479357809655;3479.6172421033666;3489.7262499188123;6323.715432805535;6324.146240257506;6358.1416508771645;6387.169667943138;6431.967840160769;6642.568233064835;6743.730250789913;6760.290169532227;6781.220159681601;6802.727890884408;6367.649779262092;6383.96808015957;6386.680665966776;6411.781761465213;6420.58266212704;6143.201383820075;6456.063181045762;6495.512836537184;6675.966620166868;6683.732650693918;6347.746090156526;6391.762882990916;6400.359964003563;6448.29068802422;6450.741970321134;6083.452489275986;6126.23422072241;6218.968905155445;6331.461825744863;6354.968225158845;4832.95167048325;4873.95126048735;4896.975515122402;4907.116718990616;4952.182889823139;6406;6434.227892652912;6511.902321465276;6599.96700016516;6610.570312929644;6265.624062556261;6452.322506136788;6464.547481676237;6524.249711283263;6540.672966351759;6339.619622822645;6366.5225108118;6477.77327793525;6511.9348806511325;6514.9348506514325;6273.811785646438;6295.929691952288;6323.490462793194;6364.93635063662;6424.678766061585;6343.175387199634;6525.836854078686;6530.934690653223;6541.476681865344;6587.2753997061245;6183.505319574333;6224.37756224374;6257.1552840367785;6267.4045965633195;6284 03:15:04 INFO - PID 3804 | |5;yui.html;911.7948461596142;913.5843191347941;941.4821847983608;943.6414162618204;945.5933948402186;17774.555636109104;18045.09774511274;18156;18164.636707265847;18289.359872404468;18267.269309227617;18306;18335.54161145972;18409.07954602268;18483.445496635122;949.8100379924026;956.2159029595734;956.6030097509525;960.2941837749248;960.865478832964;964.5755867418349;973.177664873181;977.4477420257567;977.9706608801712;978.6623614852864;966.096699585886;1021.2646894236138;1029.963951261706;1034.5913364221128;1041.6927006533053;1013.2350075692841;1018.9643362482315;1020.6274709730969;1021.9284650074497;1033.5968972100811;738.7008261654039;742.6064185981385;743.141671369569;743.4349894080538;744.3933194446563;19407;20207.797922020887;20244.595108097903;20297.188112475484;20362.694559581618;21080.5783884323;21267.36197914065;21542.246021389332;21632.783672163234;22024.008919598655;16793.160341982853;16985.91507042457;17164.656706865917;17225.827741722547;17306.307747690076;3771.453139294787;3788.0719223790074;3813.1420430403214;3823.2735780201674;3826.4069069294305;104711.47644261806;125750.37124814409;142972.2851385747;143309;144363;16996;17530.824691752918;17554.912225439046;17636.118194090242;17669.734953975443;31285.687143128733;32120.196995074843;32171.195720107185;32372.35255294881;32420.83789581037;8729.21437070654;9008.324375671851;9027.548622568846;9081.77295567616;9194.402363846462;4126.7523948563185;4159.459270294903;4237.745735255895;4247.320428731388;4254.680898932593;5526.281583394133;5577.274954256002;5605;5625.521830644359;5633.211350410946;1057.825458799305;1075.3171735947728;1084.3439718970067;1100.378286268272;1101.8457415961773;638.9648569328639;657.6875983907605;672.3276723276625;673.1014096181555;674.4132604634;11770.58802941893;11800.82298765502;11973.102017348734;12283.631491055283;12392.938035309766;689.2327305866949;691.789004353677;695.1102588686389;698.2947223304398;706.9399101076466;5509.807156749494;5519.227308176858;5559.499645031967;5565.332160140809;5627.549796016309;118414.40792795981;118490.4075479617;122124;122126;126441;82131.5893420529;108479.45760271148;118834.4058279703;124556;127665;103313;104257.99999999849;106301.46849265859;107644;109323;12231;12479.251244925334;12509.687257818627;12623.179493332904;12758.872411275768;40358.79820600878;41179.38230926479;41535.7923210382;41993.79003105087;42280.154396911275;55963.720181398836;56199;56770.71614641901;56775.71612142078;57066.42933570611;16286.429974950819;16471.505854824376;16560.834391655928;16741.414050508174;16758.245878935722;19661.705074424182;19889.403317900487;19978.400647980583;20495;20616.79383206209;16983.49049528516;17057.658846823244;17082.402115925885;17139.057351845768;17499.7375039372;17878.28486860511;18034.72947905756;18139.27442902269;18150.27398904029;18199.636007279514;17623.911880440515;17852.19665115047;17921.10394480297;18265.360712375004;18293.90853045726;13018.2839943804;13124.40940157676;13305.401256943267;13561.93219033938;13840.584782456543;13432.932835336152;13499.190048597116;13526.323683815966;13558.254296013814;13593.52422665202 03:15:04 INFO - PID 3804 | __end_tp_report 03:15:04 INFO - PID 3804 | __start_cc_report 03:15:04 INFO - PID 3804 | _x_x_mozilla_cycle_collect,302 03:15:04 INFO - PID 3804 | __end_cc_report 03:15:04 INFO - PID 3804 | __startTimestamp1505816104167__endTimestamp 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | ------- Summary: start ------- 03:15:04 INFO - PID 3804 | Number of tests: 6 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#0] dojo.html Cycles:165 Average:6104.82 Median:6394.62 stddev:877.24 (13.7%) stddev-sans-first:847.19 03:15:04 INFO - PID 3804 | Values: 3078.6 3108.9 3128.1 3130.5 3139.4 6073.9 6242.9 6277.2 6298.3 6308.2 6164.2 6207.9 6208.8 6219.3 6228.2 5665.4 5668.7 5701.1 5783.8 5835.1 5788.5 5813.6 5832.0 5833.0 5877.6 80.9 5671.2 5737.6 5864.6 5895.5 5313.4 5684.5 5765.2 5833.7 5836.2 5645.9 5746.7 5800.4 5805.0 5820.9 6221.8 6234.1 6273.3 6299.7 6350.4 6656.8 6695.4 6695.5 6765.1 6778.9 6523.8 6737.4 6766.9 6817.7 6865.9 6154.8 6161.1 6192.3 6301.8 6311.2 6921.3 6945.8 6967.5 7011.5 7017.3 6499.1 6600.4 6621.7 6658.3 6660.6 6387.8 6689.2 6725.5 6787.5 6819.9 6501.3 6505.5 6532.5 6566.0 6580.9 6494.9 6581.3 6583.5 6588.8 6606.9 5238.0 5309.7 5328.3 5333.1 5334.8 4514.8 4521.3 4569.2 4644.5 4659.1 5680.4 5747.4 5752.2 5754.5 5761.8 6666.3 6667.4 6691.3 6747.9 6748.1 5542.3 5608.1 5617.7 5651.8 5727.7 5644.1 5690.9 5692.9 5698.3 5705.1 6364.2 6445.4 6552.6 6553.5 6561.6 6687.0 6707.4 6721.5 6792.1 6844.9 6388.6 6473.8 6494.3 6576.1 6579.7 6426.1 6506.8 6563.7 6583.0 6674.1 6576.2 6614.7 6615.3 6631.2 6633.2 6438.6 6456.0 6461.9 6489.4 6514.2 6446.8 6553.9 6572.8 6573.9 6583.5 6414.3 6418.7 6445.3 6490.9 6508.2 6309.4 6499.1 6512.1 6548.7 6592.2 6355.6 6364.4 6373.8 6386.1 6394.6 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#1] ext.html Cycles:180 Average:36703.25 Median:35241.24 stddev:51702.10 (146.7%) stddev-sans-first:51776.99 03:15:04 INFO - PID 3804 | Values: 835.8 851.3 884.5 899.9 911.1 39343.6 40243.0 40357.0 40357.4 40407.8 36928.4 37149.6 37163.8 37247.6 37369.0 6986.9 7089.5 7109.9 7140.8 7178.2 7036.2 7078.7 7082.9 7098.5 7130.8 7097.2 7134.3 7217.2 7994.2 8031.7 7900.2 7900.8 7992.1 7994.6 7999.4 7818.5 7873.3 7896.0 7903.3 7905.6 37350.3 38072.2 38182.4 38318.4 38407.4 3548.8 3553.8 3559.4 3580.7 3592.8 31053.8 31070.7 31109.4 31154.2 31321.8 5122.4 5152.5 5156.4 5167.6 5204.8 183489.0 185364.0 185423.1 185436.0 185499.0 46890.5 46989.5 47116.5 47195.5 47335.0 49010.8 49055.3 49098.0 49265.8 49377.3 15593.5 15780.4 15895.7 15901.4 15918.8 12926.7 12940.9 12964.0 12977.4 13047.7 13678.6 13753.2 13886.2 13953.1 14115.9 5763.5 5765.3 5770.6 5916.6 5974.1 1034.3 1034.5 1042.6 1045.5 1058.0 22890.8 23008.3 23017.3 23053.4 23065.2 1126.7 1130.5 1146.3 1151.5 1154.7 11998.8 12033.5 12335.8 12392.5 12443.8 210022.0 210215.0 211137.0 211651.0 212741.0 42554.6 42731.6 49637.3 49807.5 50125.2 1459.4 1484.1 1484.7 1487.2 1487.9 27404.7 27716.6 27927.0 27985.7 28081.6 37135.3 37794.2 37858.4 37941.6 38019.8 202157.0 202383.0 203819.0 203913.0 204569.0 34439.7 35208.8 35223.6 35338.3 35908.6 42906.0 43108.0 43182.6 43295.6 43552.6 29933.6 31779.4 31949.7 32436.8 32845.2 31201.5 31345.7 31701.2 31830.0 31893.8 33799.0 34627.5 35093.3 35258.8 35797.0 31147.0 31317.7 31571.0 31667.8 31724.2 23335.6 23421.9 23567.2 23911.3 24079.0 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#2] jquery.html Cycles:180 Average:33980.28 Median:21443.12 stddev:76013.09 (354.5%) stddev-sans-first:76184.96 03:15:04 INFO - PID 3804 | Values: 577.9 578.6 580.5 584.6 591.1 21882.9 22623.0 22640.4 22668.1 22668.1 23863.6 24344.5 24889.9 24900.9 25178.6 6415.5 6479.6 6552.7 6556.7 6558.6 6144.1 6421.9 6504.7 6527.4 6532.5 6397.1 6413.6 6433.9 6455.0 6464.3 6442.3 6459.7 6467.4 6474.6 6482.1 5832.1 5987.0 5993.9 6007.2 6088.0 27152.3 27275.5 27669.2 27738.0 27748.0 1985.5 2001.1 2003.6 2013.3 2019.2 18262.5 18770.0 19077.2 19121.3 19131.1 2325.2 2393.9 2414.0 2428.7 2438.3 120424.0 124528.4 125260.4 137037.0 141403.3 19432.5 20158.7 20282.5 20540.8 21504.7 39263.4 39681.0 39744.0 39747.0 39833.4 11172.0 11256.7 11400.5 11416.3 11497.0 9342.5 9549.4 9565.4 9598.5 9698.2 10345.0 10890.9 11004.0 11052.9 11119.9 4093.5 4103.7 4130.7 4258.2 4281.7 940.8 946.9 966.6 972.2 978.9 18417.9 18710.2 18867.9 18981.8 19044.5 1013.3 1026.7 1032.1 1034.6 1035.4 10375.4 10450.6 10628.4 10790.9 10860.9 440692.0 442692.0 454429.0 455981.0 456317.0 111111.4 113738.0 114265.0 114889.4 117164.4 1160.9 1170.2 1176.8 1205.9 1213.1 16879.9 16916.9 16918.3 16921.9 17038.2 56126.4 56196.0 56221.4 56473.4 57805.7 68765.3 68930.0 69591.3 70017.0 70094.3 18401.5 18847.4 18879.2 18908.6 19265.1 21004.5 21381.6 21553.4 21640.4 21668.6 17341.7 17500.0 17528.6 17636.2 17643.3 15050.9 15682.5 16265.3 16282.3 16519.4 17638.4 17983.3 17992.6 18081.5 18305.5 18015.1 18165.9 18247.1 18266.3 18366.0 16868.5 17441.8 17470.0 17500.3 17678.9 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#3] mootools.html Cycles:180 Average:9365.39 Median:26829.20 stddev:6804.62 (25.4%) stddev-sans-first:6796.74 03:15:04 INFO - PID 3804 | Values: 1301.9 1396.6 1400.4 1408.4 1408.5 15512.2 15848.4 15848.6 15936.4 15968.9 15583.1 15753.4 15796.1 15836.9 15847.2 2711.4 2768.9 2786.8 2794.9 2800.3 2691.5 2734.9 2743.1 2745.1 2752.0 2621.5 2658.7 2674.7 2714.1 2750.3 2668.6 2677.8 2712.1 2713.9 2725.6 2643.8 2649.0 2660.5 2678.7 2679.2 14531.6 14870.9 14894.7 14908.6 14921.8 8068.0 8310.1 8342.9 8353.3 8371.2 5137.9 5289.5 5317.9 5346.9 5376.6 1953.9 1963.9 1991.7 2031.8 2037.1 26822.2 26836.2 27045.6 27307.6 27611.2 6834.1 6949.0 7105.6 7208.8 7217.9 17333.7 17399.8 17416.0 17540.7 17598.1 7765.0 7810.8 7914.9 7924.2 7927.2 7253.7 7273.9 7293.7 7318.5 7420.6 5203.4 5367.3 5386.5 5397.2 5407.5 1509.0 1513.5 1532.7 1533.4 1535.4 848.1 853.1 862.3 866.5 879.9 7133.9 7170.1 7192.8 7231.9 7249.7 664.5 695.5 703.6 704.8 730.6 4188.6 4229.6 4249.7 4278.1 4726.3 21215.3 21548.5 21859.2 22006.3 22039.2 20442.9 21494.1 21843.2 21863.7 22092.4 10672.7 10805.9 10821.9 10968.2 11429.0 7671.5 8132.0 8184.3 8222.3 8237.7 18916.2 18923.9 19010.2 19190.2 19214.4 18490.7 19024.1 19426.6 19468.2 19477.5 10923.9 10951.1 11012.5 11021.2 11039.7 13782.2 14064.4 14156.6 14158.3 14233.6 11548.3 11666.9 11993.2 12050.9 12129.3 11255.4 11279.9 11347.8 11458.5 11585.2 9750.2 9848.6 9932.0 9932.0 9932.8 7291.2 7301.4 7302.5 7335.0 7401.6 7284.9 7315.3 7330.5 7418.5 7443.6 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#4] prototype.html Cycles:180 Average:5420.71 Median:6079.44 stddev:1509.03 (24.8%) stddev-sans-first:1467.30 03:15:04 INFO - PID 3804 | Values: 496.0 497.6 515.7 518.8 531.2 6109.6 6162.2 6170.4 6174.1 6237.9 6051.7 6075.4 6094.5 6160.3 6182.7 5053.5 5121.3 5125.7 5127.5 5134.3 5138.7 5166.5 5188.0 5218.9 5222.7 4733.9 4927.6 4935.6 4948.2 4971.2 4910.4 4912.2 4942.8 4965.2 4967.4 4339.9 4392.6 4395.7 4414.1 4417.7 5982.7 6028.0 6049.2 6063.9 6093.8 5584.6 5597.7 5625.6 5671.1 5682.4 6358.1 6374.9 6450.3 6474.2 6532.3 4571.3 4822.8 4853.8 4888.2 4898.0 6609.8 6689.2 6748.8 6796.6 6842.9 4898.7 4911.9 4951.5 4959.6 5005.3 4957.4 4984.7 5005.4 5044.3 5048.2 5606.0 5645.3 5652.0 5658.3 5675.7 6420.8 6500.4 6543.7 6545.7 6555.1 1693.7 1721.4 1724.7 1741.6 1743.4 1113.3 1191.7 1199.8 1219.8 1231.3 5507.9 5546.7 5591.9 5624.6 5636.0 6471.7 6477.4 6550.5 6565.2 6590.6 5537.8 5539.8 5546.9 5557.5 5568.1 3405.9 3431.6 3470.9 3479.6 3489.7 6323.7 6324.1 6358.1 6387.2 6432.0 6642.6 6743.7 6760.3 6781.2 6802.7 6367.6 6384.0 6386.7 6411.8 6420.6 6143.2 6456.1 6495.5 6676.0 6683.7 6347.7 6391.8 6400.4 6448.3 6450.7 6083.5 6126.2 6219.0 6331.5 6355.0 4833.0 4874.0 4897.0 4907.1 4952.2 6406.0 6434.2 6511.9 6600.0 6610.6 6265.6 6452.3 6464.5 6524.2 6540.7 6339.6 6366.5 6477.8 6511.9 6514.9 6273.8 6295.9 6323.5 6364.9 6424.7 6343.2 6525.8 6530.9 6541.5 6587.3 6183.5 6224.4 6257.2 6267.4 6284.0 03:15:04 INFO - PID 3804 | 03:15:04 INFO - PID 3804 | [#5] yui.html Cycles:180 Average:24794.49 Median:18372.31 stddev:35484.41 (193.1%) stddev-sans-first:35538.64 03:15:04 INFO - PID 3804 | Values: 911.8 913.6 941.5 943.6 945.6 17774.6 18045.1 18156.0 18164.6 18289.4 18267.3 18306.0 18335.5 18409.1 18483.4 949.8 956.2 956.6 960.3 960.9 964.6 973.2 977.4 978.0 978.7 966.1 1021.3 1030.0 1034.6 1041.7 1013.2 1019.0 1020.6 1021.9 1033.6 738.7 742.6 743.1 743.4 744.4 19407.0 20207.8 20244.6 20297.2 20362.7 21080.6 21267.4 21542.2 21632.8 22024.0 16793.2 16985.9 17164.7 17225.8 17306.3 3771.5 3788.1 3813.1 3823.3 3826.4 104711.5 125750.4 142972.3 143309.0 144363.0 16996.0 17530.8 17554.9 17636.1 17669.7 31285.7 32120.2 32171.2 32372.4 32420.8 8729.2 9008.3 9027.5 9081.8 9194.4 4126.8 4159.5 4237.7 4247.3 4254.7 5526.3 5577.3 5605.0 5625.5 5633.2 1057.8 1075.3 1084.3 1100.4 1101.8 639.0 657.7 672.3 673.1 674.4 11770.6 11800.8 11973.1 12283.6 12392.9 689.2 691.8 695.1 698.3 706.9 5509.8 5519.2 5559.5 5565.3 5627.5 118414.4 118490.4 122124.0 122126.0 126441.0 82131.6 108479.5 118834.4 124556.0 127665.0 103313.0 104258.0 106301.5 107644.0 109323.0 12231.0 12479.3 12509.7 12623.2 12758.9 40358.8 41179.4 41535.8 41993.8 42280.2 55963.7 56199.0 56770.7 56775.7 57066.4 16286.4 16471.5 16560.8 16741.4 16758.2 19661.7 19889.4 19978.4 20495.0 20616.8 16983.5 17057.7 17082.4 17139.1 17499.7 17878.3 18034.7 18139.3 18150.3 18199.6 17623.9 17852.2 17921.1 18265.4 18293.9 13018.3 13124.4 13305.4 13561.9 13840.6 13432.9 13499.2 13526.3 13558.3 13593.5 03:15:04 INFO - PID 3804 | -------- Summary: end -------- 03:15:04 INFO - PID 3804 | 03:15:05 INFO - TEST-INFO | 3804: exit 0 03:15:05 INFO - TEST-OK | dromaeo_css | took 1115447ms 03:15:05 INFO - TEST-START | kraken 03:15:05 INFO - Initialising browser for kraken test... 03:15:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51852/getInfo.html -profile /tmp/tmpDAA94x/profile 03:15:05 INFO - TEST-INFO | started process 4184 (/builds/slave/test/build/application/firefox/firefox http://localhost:51852/getInfo.html) 03:15:11 INFO - TEST-INFO | 4184: exit 0 03:15:11 INFO - Browser initialized. 03:15:11 INFO - Running cycle 1/1 for kraken test... 03:15:11 INFO - Using env: {'DISPLAY': ':0', 03:15:11 INFO - 'HOME': '/home/cltbld', 03:15:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:15:11 INFO - 'LANG': 'en_US.UTF-8', 03:15:11 INFO - 'LANGUAGE': 'en_US:en', 03:15:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:15:11 INFO - 'LOGNAME': 'cltbld', 03:15:11 INFO - 'MAIL': '/var/mail/cltbld', 03:15:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:11 INFO - 'MOZ_ACCELERATED': '1', 03:15:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:15:11 INFO - 'MOZ_NO_REMOTE': '1', 03:15:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'MOZ_WEBRENDER': '1', 03:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:11 INFO - 'NO_EM_RESTART': '1', 03:15:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:11 INFO - 'PWD': '/builds/slave/test', 03:15:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:11 INFO - 'RUST_BACKTRACE': 'full', 03:15:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:11 INFO - 'SHELL': '/bin/bash', 03:15:11 INFO - 'SHLVL': '1', 03:15:11 INFO - 'TERM': 'linux', 03:15:11 INFO - 'TMOUT': '86400', 03:15:11 INFO - 'USER': 'cltbld', 03:15:11 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056', 03:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:11 INFO - '_': '/tools/buildbot/bin/python'} 03:15:11 INFO - TEST-INFO | started process 4428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDAA94x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:12 INFO - PID 4428 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:15:12 INFO - PID 4428 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:15:12 INFO - PID 4428 | 03:15:12 INFO - PID 4428 | (/builds/slave/test/build/application/firefox/firefox:4487): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:15:12 INFO - PID 4428 | 03:15:22 INFO - PID 4428 | RSS: Main: 207790080 03:15:22 INFO - PID 4428 | 03:15:25 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51852/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:26 INFO - PID 4428 | RSS: Main: 206741504 03:15:26 INFO - PID 4428 | 03:15:29 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51852/tests/kraken/driver.html?testName=audio-dft) 03:15:29 INFO - PID 4428 | RSS: Main: 206196736 03:15:29 INFO - PID 4428 | 03:15:32 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51852/tests/kraken/driver.html?testName=audio-fft) 03:15:33 INFO - PID 4428 | RSS: Main: 201916416 03:15:33 INFO - PID 4428 | 03:15:35 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51852/tests/kraken/driver.html?testName=audio-oscillator) 03:15:36 INFO - PID 4428 | RSS: Main: 203268096 03:15:36 INFO - PID 4428 | 03:15:38 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:38 INFO - PID 4428 | RSS: Main: 204288000 03:15:38 INFO - PID 4428 | 03:15:42 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51852/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:42 INFO - PID 4428 | RSS: Main: 205725696 03:15:42 INFO - PID 4428 | 03:15:46 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51852/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:47 INFO - PID 4428 | RSS: Main: 206544896 03:15:47 INFO - PID 4428 | 03:15:50 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51852/tests/kraken/driver.html?testName=json-parse-financial) 03:15:50 INFO - PID 4428 | RSS: Main: 205193216 03:15:50 INFO - PID 4428 | 03:15:52 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:52 INFO - PID 4428 | RSS: Main: 206958592 03:15:52 INFO - PID 4428 | 03:15:54 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:55 INFO - PID 4428 | RSS: Main: 204009472 03:15:55 INFO - PID 4428 | 03:15:57 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:58 INFO - PID 4428 | RSS: Main: 202756096 03:15:58 INFO - PID 4428 | 03:16:00 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:01 INFO - PID 4428 | RSS: Main: 203751424 03:16:01 INFO - PID 4428 | 03:16:04 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:05 INFO - PID 4428 | RSS: Main: 204255232 03:16:05 INFO - PID 4428 | 03:16:06 INFO - PID 4428 | Cycle 1(1): loaded http://localhost:51852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51852/tests/kraken/driver.html?testName=ai-astar) 03:16:07 INFO - PID 4428 | RSS: Main: 204337152 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | __start_tp_report 03:16:07 INFO - PID 4428 | _x_x_mozilla_page_load 03:16:07 INFO - PID 4428 | _x_x_mozilla_page_load_details 03:16:07 INFO - PID 4428 | |i|pagename|runs| 03:16:07 INFO - PID 4428 | |0;ai-astar;108;106;107;115;113;115;107;111;107;115 03:16:07 INFO - PID 4428 | |1;audio-beat-detection;118;119;131;118;116;115;151;123;123;122 03:16:07 INFO - PID 4428 | |2;audio-dft;162;168;162;164;163;163;170;170;162;165 03:16:07 INFO - PID 4428 | |3;audio-fft;73;81;77;76;81;83;76;81;82;81 03:16:07 INFO - PID 4428 | |4;audio-oscillator;80;84;89;83;82;78;81;84;86;82 03:16:07 INFO - PID 4428 | |5;imaging-gaussian-blur;110;114;113;114;120;120;117;119;118;115 03:16:07 INFO - PID 4428 | |6;imaging-darkroom;149;150;151;149;149;148;148;148;149;149 03:16:07 INFO - PID 4428 | |7;imaging-desaturate;100;95;104;95;100;98;95;96;95;94 03:16:07 INFO - PID 4428 | |8;json-parse-financial;60;56;53;66;56;57;64;52;55;53 03:16:07 INFO - PID 4428 | |9;json-stringify-tinderbox;43;47;38;38;46;37;38;48;38;38 03:16:07 INFO - PID 4428 | |10;stanford-crypto-aes;80;75;74;73;81;74;82;80;74;82 03:16:07 INFO - PID 4428 | |11;stanford-crypto-ccm;114;124;112;126;120;120;130;120;112;111 03:16:07 INFO - PID 4428 | |12;stanford-crypto-pbkdf2;173;172;183;176;172;172;169;169;170;178 03:16:07 INFO - PID 4428 | |13;stanford-crypto-sha256-iterative;67;65;73;64;67;64;63;67;66;72 03:16:07 INFO - PID 4428 | __end_tp_report 03:16:07 INFO - PID 4428 | __start_cc_report 03:16:07 INFO - PID 4428 | _x_x_mozilla_cycle_collect,741 03:16:07 INFO - PID 4428 | __end_cc_report 03:16:07 INFO - PID 4428 | __startTimestamp1505816167080__endTimestamp 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | ------- Summary: start ------- 03:16:07 INFO - PID 4428 | Number of tests: 14 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:3.94 03:16:07 INFO - PID 4428 | Values: 108.0 106.0 107.0 115.0 113.0 115.0 107.0 111.0 107.0 115.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:122.50 stddev:10.67 (8.7%) stddev-sans-first:11.12 03:16:07 INFO - PID 4428 | Values: 118.0 119.0 131.0 118.0 116.0 115.0 151.0 123.0 123.0 122.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.25 (2.0%) stddev-sans-first:3.27 03:16:07 INFO - PID 4428 | Values: 162.0 168.0 162.0 164.0 163.0 163.0 170.0 170.0 162.0 165.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#3] audio-fft Cycles:10 Average:79.10 Median:81.00 stddev:3.31 (4.1%) stddev-sans-first:2.68 03:16:07 INFO - PID 4428 | Values: 73.0 81.0 77.0 76.0 81.0 83.0 76.0 81.0 82.0 81.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:3.11 (3.7%) stddev-sans-first:3.11 03:16:07 INFO - PID 4428 | Values: 80.0 84.0 89.0 83.0 82.0 78.0 81.0 84.0 86.0 82.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:117.50 stddev:3.33 (2.8%) stddev-sans-first:2.74 03:16:07 INFO - PID 4428 | Values: 110.0 114.0 113.0 114.0 120.0 120.0 117.0 119.0 118.0 115.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 03:16:07 INFO - PID 4428 | Values: 149.0 150.0 151.0 149.0 149.0 148.0 148.0 148.0 149.0 149.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:95.00 stddev:3.22 (3.4%) stddev-sans-first:3.26 03:16:07 INFO - PID 4428 | Values: 100.0 95.0 104.0 95.0 100.0 98.0 95.0 96.0 95.0 94.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.50 stddev:4.73 (8.4%) stddev-sans-first:4.91 03:16:07 INFO - PID 4428 | Values: 60.0 56.0 53.0 66.0 56.0 57.0 64.0 52.0 55.0 53.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#9] json-stringify-tinderbox Cycles:10 Average:41.10 Median:40.50 stddev:4.41 (10.9%) stddev-sans-first:4.62 03:16:07 INFO - PID 4428 | Values: 43.0 47.0 38.0 38.0 46.0 37.0 38.0 48.0 38.0 38.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:80.00 stddev:3.78 (4.7%) stddev-sans-first:3.90 03:16:07 INFO - PID 4428 | Values: 80.0 75.0 74.0 73.0 81.0 74.0 82.0 80.0 74.0 82.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:120.00 stddev:6.54 (5.4%) stddev-sans-first:6.69 03:16:07 INFO - PID 4428 | Values: 114.0 124.0 112.0 126.0 120.0 120.0 130.0 120.0 112.0 111.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:172.50 stddev:4.43 (2.6%) stddev-sans-first:4.69 03:16:07 INFO - PID 4428 | Values: 173.0 172.0 183.0 176.0 172.0 172.0 169.0 169.0 170.0 178.0 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:3.33 (5.0%) stddev-sans-first:3.53 03:16:07 INFO - PID 4428 | Values: 67.0 65.0 73.0 64.0 67.0 64.0 63.0 67.0 66.0 72.0 03:16:07 INFO - PID 4428 | -------- Summary: end -------- 03:16:07 INFO - PID 4428 | 03:16:07 INFO - PID 4428 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:16:07 INFO - TEST-INFO | 4428: exit 0 03:16:08 INFO - TEST-OK | kraken | took 62915ms 03:16:08 INFO - SUITE-END | took 1178s 03:16:08 INFO - Completed test suite (00:19:38) 03:16:08 INFO - javascript benchmark 03:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8528.043102990068, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.6459557150934, 3108.8601012954414, 3128.1241252449313, 3130.499120140778, 3139.4035133324664, 6073.878522429549, 6242.906356404652, 6277.246730392348, 6298.307186209513, 6308.1799366082405, 6164.167837341957, 6207.937920620792, 6208.751649933997, 6219.284782250032, 6228.22147231596, 5665.433456654343, 5668.744906479208, 5701.059325211335, 5783.82648520543, 5835.095560188178, 5788.536917046647, 5813.6221145625395, 5831.970840145815, 5833.008388573952, 5877.6473411595225, 80.92326345065315, 5671.177679236487, 5737.598368114233, 5864.560157988168, 5895.469407753301, 5313.38896026958, 5684.459976302244, 5765.1928729977835, 5833.7083145842535, 5836.182934389147, 5645.8588535286535, 5746.683932383718, 5800.419958004166, 5804.970975145139, 5820.941790582125, 6221.782237621706, 6234.064890266451, 6273.278572964076, 6299.6850157491945, 6350.396712312323, 6656.833579160511, 6695.430888374494, 6695.531312808105, 6765.05289259504, 6778.932210677879, 6523.7716679915975, 6737.393634572912, 6766.932330676679, 6817.693203805791, 6865.9313406865795, 6154.815355539341, 6161.075838624242, 6192.318844927055, 6301.779437719703, 6311.179546658951, 6921.307869213038, 6945.756898508528, 6967.477439192081, 7011.474139439562, 7017.333353331425, 6499.122618446449, 6600.405963463311, 6621.668916554249, 6658.300878407795, 6660.600363978177, 6387.808365749035, 6689.1972963244725, 6725.529212955046, 6787.490938179656, 6819.863602728017, 6501.349865013555, 6505.544611877123, 6532.477401807844, 6565.967170164118, 6580.901286480706, 6494.9350506495275, 6581.3418658133805, 6583.506237032242, 6588.8023359299295, 6606.86786264272, 5237.973810131001, 5309.7079660618265, 5328.254044433782, 5333.066713325153, 5334.839954801362, 4514.841980530731, 4521.299198624219, 4569.223232050559, 4644.512326205768, 4659.068186362741, 5680.375158732536, 5747.39652336507, 5752.223449834302, 5754.539636829044, 5761.827145185651, 6666.333366663392, 6667.366600173073, 6691.297413771581, 6747.932520674731, 6748.122744043243, 5542.307211598551, 5608.130739735348, 5617.662940223599, 5651.773929042793, 5727.742251598688, 5644.125160600031, 5690.9146362804595, 5692.943070569241, 5698.344690360662, 5705.115707065412, 6364.172657554488, 6445.387688169616, 6552.63960482178, 6553.475721942328, 6561.606303621798, 6686.96656516724, 6707.429868461236, 6721.529492935448, 6792.08306878575, 6844.863102737818, 6388.584741991755, 6473.805785826433, 6494.318096599789, 6576.145101136822, 6579.671016449254, 6426.068220108152, 6506.837329066622, 6563.704633291609, 6583.0, 6674.132362792806, 6576.177977752781, 6614.70233839488, 6615.338466153346, 6631.237407698177, 6633.2040155181685, 6438.645874476949, 6456.0, 6461.903071453838, 6489.448396886318, 6514.185726784152, 6446.8388290293115, 6553.934460655332, 6572.8356791080605, 6573.934260657332, 6583.473322134314, 6414.262359828679, 6418.743250270124, 6445.291017988111, 6490.902636460362, 6508.153939987771, 6309.400606942333, 6499.122618446639, 6512.120863683532, 6548.672566371758, 6592.208934927839, 6355.586886852339, 6364.427201551883, 6373.840653983688, 6386.074019267087, 6394.616323020447], "value": 6042.42820403759, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.7994081420461, 851.3487182305533, 884.4914174349749, 899.8920129584455, 911.084360217981, 39343.60656393435, 40243.0, 40357.0, 40357.394639080434, 40407.797961010154, 36928.44607330892, 37149.62850371496, 37163.81418092906, 37247.627523724754, 37369.0, 6986.930130698692, 7089.468289878279, 7109.8933515997305, 7140.821479463003, 7178.246284140168, 7036.226015138331, 7078.716851325941, 7082.893756593655, 7098.503104782667, 7130.786076417716, 7097.183823860245, 7134.286571342876, 7217.242189570098, 7994.160613135624, 8031.718889838857, 7900.170482099383, 7900.80247993799, 7992.080910695287, 7994.64024118916, 7999.400044996649, 7818.530888146673, 7873.330766884765, 7895.960520197362, 7903.288704016666, 7905.644246008886, 37350.25299494022, 38072.23855522874, 38182.42726359107, 38318.42522362139, 38407.42388864169, 3548.822558872046, 3553.8045407502577, 3559.4482855157494, 3580.677739003502, 3592.838322275478, 31053.84473077643, 31070.689293107007, 31109.37781244385, 31154.221144471343, 31321.8433907829, 5122.436531981479, 5152.5105115014385, 5156.407013193493, 5167.612429067797, 5204.791808327663, 183489.0, 185364.0, 185423.07288463606, 185436.0, 185499.0, 46890.5310946893, 46989.53010469852, 47116.5288347119, 47195.52804471911, 47335.0, 49010.75494622575, 49055.26417103747, 49098.0, 49265.75367123142, 49377.259341109915, 15593.532194034196, 15780.447684330993, 15895.68208635844, 15901.363945442285, 15918.840811591968, 12926.67683307906, 12940.870591294155, 12964.0, 12977.35113244334, 13047.739045219043, 13678.589642310746, 13753.243571603658, 13886.166829990232, 13953.093048951785, 14115.929420353037, 5763.538916886639, 5765.336986246635, 5770.624909380961, 5916.615419997773, 5974.133750606138, 1034.3276870034538, 1034.4724190662816, 1042.5985995391677, 1045.513836066233, 1057.9682609521574, 22890.771092289197, 23008.309750707507, 23017.309480715605, 23053.423664408525, 23065.19271825478, 1126.707056165403, 1130.496928866663, 1146.2549342926998, 1151.5336288803048, 1154.6766905266538, 11998.760024799456, 12033.518659253707, 12335.814962775565, 12392.504299827906, 12443.751124977449, 210022.0, 210215.0, 211137.0, 211651.0, 212741.0, 42554.57445425568, 42731.57268427338, 49637.25544116841, 49807.501924981014, 50125.24812127821, 1459.4454107439317, 1484.050207866966, 1484.6807936293749, 1487.152323175801, 1487.9404823807142, 27404.725952740217, 27716.566866267465, 27927.022554210504, 27985.720142798313, 28081.57877631878, 37135.25729485449, 37794.24411511809, 37858.43212351872, 37941.62058379381, 38019.80990095032, 202157.0, 202383.0, 203819.0, 203913.0, 204569.0, 34439.65560344465, 35208.823955880056, 35223.64776352306, 35338.293234135686, 35908.64091359053, 42906.0, 43108.0, 43182.56817431786, 43295.56704432915, 43552.56447435612, 29933.55099673463, 31779.36441271208, 31949.68050319467, 32436.83781581077, 32845.17887052843, 31201.53197701991, 31345.686543134278, 31701.207469812518, 31830.0, 31893.8405307972, 33799.0, 34627.4805877907, 35093.29813403769, 35258.8237058813, 35797.0, 31147.0, 31317.686823131477, 31571.0, 31667.84166079155, 31724.206894827814, 23335.649965250876, 23421.88289058544, 23567.17514886971, 23911.28266152018, 24079.0], "value": 17009.653725200467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8873119741652, 578.6094386289253, 580.4978693430181, 584.5937073733754, 591.1044767177726, 21882.89058554709, 22623.0, 22640.43398915028, 22668.09327626893, 22668.09327626897, 23863.64204536933, 24344.51310973784, 24889.875550622266, 24900.875495622495, 25178.622320665203, 6415.454686351654, 6479.578827376229, 6552.672366381686, 6556.704948277339, 6558.639274839906, 6144.139820425144, 6421.8715625687455, 6504.70728817202, 6527.41253287204, 6532.542722009462, 6397.136386587821, 6413.647249401281, 6433.93566064338, 6454.9677251613675, 6464.3212462691445, 6442.259140198867, 6459.741610335581, 6467.385598368194, 6474.5791523550815, 6482.060101285334, 5832.096025116114, 5986.970065149646, 5993.9400605993815, 6007.219061521974, 6087.969560152215, 27152.32119197016, 27275.45449091007, 27669.169924902286, 27738.0, 27748.0, 1985.463924740312, 2001.0695026812457, 2003.5692326149947, 2013.2953466286683, 2019.1822311963679, 18262.452126436227, 18770.0, 19077.236910523563, 19121.330753423703, 19131.13909874059, 2325.209428794218, 2393.9162129325564, 2413.9517209655883, 2428.659987601737, 2438.317271164077, 120424.0, 124528.37735811353, 125260.37369813184, 137037.0, 141403.29298353443, 19432.514187145436, 20158.69761953572, 20282.492937676678, 20540.84321146288, 21504.677429838564, 39263.41104883429, 39681.0, 39744.0, 39747.0, 39833.40249896254, 11172.0, 11256.718582035515, 11400.486978086006, 11416.31502109876, 11497.0, 9342.532873356306, 9549.379290346244, 9565.426074435556, 9598.472084035306, 9698.175655069399, 10345.0, 10890.945545272381, 11004.0, 11052.889471105347, 11119.944400277947, 4093.488313960755, 4103.712740108163, 4130.690198235085, 4258.190943720683, 4281.709285532225, 940.8400571902793, 946.926231552897, 966.5602151021268, 972.2367941166151, 978.8580655804868, 18417.907910460362, 18710.158042888103, 18867.90566047161, 18981.810181898003, 19044.52388690266, 1013.2906965124295, 1026.6765968719828, 1032.1072272484398, 1034.632705389576, 1035.4201647077662, 10375.429351385596, 10450.634227801991, 10628.41543715103, 10790.946045269724, 10860.945695271632, 440692.0, 442692.0, 454429.0, 455981.0, 456317.0, 111111.44444277727, 113738.0, 114265.0, 114889.4255528717, 117164.41417792857, 1160.878107798686, 1170.169179882293, 1176.7705297467082, 1205.8854408831146, 1213.0841214882882, 16879.87706308476, 16916.915415422845, 16918.32326706918, 16921.915390423463, 17038.233279502205, 56126.43873561212, 56196.0, 56221.43778562325, 56473.43526564682, 57805.710971444874, 68765.3123468779, 68930.0, 69591.3040869605, 70017.0, 70094.29905700877, 18401.53996150107, 18847.434576962714, 18879.244830206637, 18908.621827563646, 19265.13306901165, 21004.47488812792, 21381.572368552854, 21553.35339939804, 21640.350789476342, 21668.566628667653, 17341.73987390165, 17500.037497937734, 17528.649427011642, 17636.20637071309, 17643.29426822964, 15050.924745376204, 15682.529524114294, 16265.268062936959, 16282.348706051625, 16519.421820236235, 17638.38265660696, 17983.280668773103, 17992.640147197246, 18081.457556273333, 18305.450836474927, 18015.099245037956, 18165.909170454594, 18247.087645617932, 18266.26934922588, 18366.0, 16868.493945181664, 17441.825581744528, 17470.03914784699, 17500.299988000846, 17678.911605441892], "value": 12391.35081781897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.882830545251, 1396.6089494941407, 1400.4118270326464, 1408.4295860176626, 1408.4929425406851, 15512.224388780558, 15848.445304414334, 15848.603784905368, 15936.362545498167, 15968.920155399235, 15583.142927139002, 15753.369865205406, 15796.131212783292, 15836.920815395935, 15847.207639618031, 2711.4441539484455, 2768.9446211075815, 2786.8467234302107, 2794.9021784237557, 2800.313923088846, 2691.5155272051024, 2734.86325683716, 2743.1496236166754, 2745.1078399520234, 2752.0, 2621.5281249375107, 2658.710525395182, 2674.6790385153713, 2714.1043455659583, 2750.2711781377952, 2668.559687651535, 2677.7723893468983, 2712.0643378034647, 2713.8778754956074, 2725.604787305849, 2643.788496920242, 2648.973510264892, 2660.521106200883, 2678.745519175695, 2679.2498100531884, 14531.564053078424, 14870.851291487163, 14894.70210595782, 14908.62728431787, 14921.776173357408, 8067.959660201662, 8310.127436619128, 8342.874856877152, 8353.289970352527, 8371.204735550113, 5137.897242055175, 5289.471052894718, 5317.893642127175, 5346.946530534684, 5376.596755243333, 1953.8827670339824, 1963.862529622927, 1991.6813309870352, 2031.7561892572985, 2037.0629510425074, 26822.195334140008, 26836.194914152606, 27045.594316085273, 27307.590386144224, 27611.171664850088, 6834.086455792386, 6949.0, 7105.573665580082, 7208.819779505554, 7217.8556428871125, 17333.7399939001, 17399.826001740075, 17416.04211768365, 17540.736888946674, 17598.12009399525, 7764.961175194087, 7810.765677029698, 7914.881276780853, 7924.247196516321, 7927.207279272142, 7253.673584688701, 7273.8545229095125, 7293.671784769698, 7318.451116166202, 7420.628968551551, 5203.401608814959, 5367.275417818544, 5386.48828361305, 5397.217403476474, 5407.513323800877, 1509.0, 1513.5459362191298, 1532.6551525906582, 1533.3866453418723, 1535.4088675859875, 848.1391387741447, 853.108501615813, 862.2584577263548, 866.4931015355961, 879.9076097009722, 7133.8929916050265, 7170.067891174114, 7192.82017949545, 7231.927680723231, 7249.710011599583, 664.5049438168595, 695.488815720445, 703.641143017065, 704.8378872859271, 730.649288341599, 4188.581141885848, 4229.577042295746, 4249.68127390447, 4278.080212754273, 4726.338312636233, 21215.257465988616, 21548.4612884676, 21859.234926777488, 22006.339809805733, 22039.228626997978, 20442.897785510977, 21494.14023439076, 21843.235486757887, 21863.672044919338, 22092.447688807588, 10672.733181670521, 10805.891941080488, 10821.891781082088, 10968.23222374426, 11428.971392574707, 7671.53970761756, 8132.0, 8184.345252379914, 8222.301104405953, 8237.670493180205, 18916.243350265835, 18923.90538047301, 19010.23959041623, 19190.232390704776, 19214.423567293004, 18490.722639160154, 19024.1439135242, 19426.611467770847, 19468.221271148996, 19477.51306217356, 10923.890761092605, 10951.069159121564, 11012.5044373005, 11021.173411993972, 11039.668809935714, 13782.241976691379, 14064.437422502986, 14156.575302740934, 14158.292085395895, 14233.64415889611, 11548.307101573933, 11666.941665291619, 11993.220440671328, 12050.879491204976, 12129.272243665408, 11255.437228138397, 11279.943600281946, 11347.829782553103, 11458.484368203617, 11585.189036767346, 9750.219982401533, 9848.606055757977, 9932.0, 9932.0, 9932.751681208028, 7291.234420385996, 7301.415886729155, 7302.488825782144, 7335.046443962464, 7401.555906645618, 7284.854302913806, 7315.341619254293, 7330.450216233698, 7418.517796343221, 7443.590602516913], "value": 6604.94689910534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.98946022397035, 497.61641736084147, 515.6570880364558, 518.7613697699059, 531.2111514401114, 6109.633421994683, 6162.168107305512, 6170.382961703827, 6174.135621013056, 6237.906431403521, 6051.697415129237, 6075.422834830695, 6094.481969032627, 6160.322364539897, 6182.7217775200115, 5053.4946505349535, 5121.3342265505435, 5125.666831655949, 5127.487251274862, 5134.306868572732, 5138.7173705446185, 5166.509181627758, 5187.974060129713, 5218.921716174261, 5222.738863056832, 4733.928991065137, 4927.556519913207, 4935.605151587864, 4948.158813001798, 4971.179755340365, 4910.435299940481, 4912.214045752698, 4942.752862356886, 4965.155923492996, 4967.410428662829, 4339.934900976488, 4392.560743925614, 4395.670324725626, 4414.095110502371, 4417.734935903856, 5982.670953097578, 6028.005379112485, 6049.153118563405, 6063.9090413643835, 6093.817185484442, 5584.636998595079, 5597.74810133545, 5625.578081643852, 5671.120976248688, 5682.374938756733, 6358.1416508771645, 6374.936250637481, 6450.258220304631, 6474.1907261592305, 6532.268948728591, 4571.291449825282, 4822.831200907986, 4853.781579828917, 4888.169011268093, 4897.975510122462, 6609.834754131137, 6689.23073846509, 6748.797536073926, 6796.592204467748, 6842.931570684279, 4898.730569818623, 4911.87720306988, 4951.529604687549, 4959.578435832923, 5005.34930459038, 4957.429895561984, 4984.725840078758, 5005.449400565934, 5044.319016932667, 5048.192289233705, 5605.971970140124, 5645.294338207724, 5652.0, 5658.321001479849, 5675.687837168913, 6420.775272865428, 6500.414962653289, 6543.738250469928, 6545.738170473128, 6555.1478307820635, 1693.6612677464557, 1721.397510871185, 1724.7499112628598, 1741.5907261793468, 1743.4420985284587, 1113.287496002559, 1191.6961174900346, 1199.7780410624061, 1219.8475190601175, 1231.2858542045592, 5507.925954438846, 5546.667199968015, 5591.8881622368135, 5624.55003599711, 5635.971820140873, 6471.708773105222, 6477.384648458389, 6550.460641749185, 6565.21217453899, 6590.604563726191, 5537.833864984057, 5539.756398658469, 5546.889062218733, 5557.527255277355, 5568.1091025435735, 3405.9489107663403, 3431.571053618298, 3470.9479357809655, 3479.6172421033666, 3489.7262499188123, 6323.715432805535, 6324.146240257506, 6358.1416508771645, 6387.169667943138, 6431.967840160769, 6642.568233064835, 6743.730250789913, 6760.290169532227, 6781.220159681601, 6802.727890884408, 6367.649779262092, 6383.96808015957, 6386.680665966776, 6411.781761465213, 6420.58266212704, 6143.201383820075, 6456.063181045762, 6495.512836537184, 6675.966620166868, 6683.732650693918, 6347.746090156526, 6391.762882990916, 6400.359964003563, 6448.29068802422, 6450.741970321134, 6083.452489275986, 6126.23422072241, 6218.968905155445, 6331.461825744863, 6354.968225158845, 4832.95167048325, 4873.95126048735, 4896.975515122402, 4907.116718990616, 4952.182889823139, 6406.0, 6434.227892652912, 6511.902321465276, 6599.96700016516, 6610.570312929644, 6265.624062556261, 6452.322506136788, 6464.547481676237, 6524.249711283263, 6540.672966351759, 6339.619622822645, 6366.5225108118, 6477.77327793525, 6511.9348806511325, 6514.9348506514325, 6273.811785646438, 6295.929691952288, 6323.490462793194, 6364.93635063662, 6424.678766061585, 6343.175387199634, 6525.836854078686, 6530.934690653223, 6541.476681865344, 6587.2753997061245, 6183.505319574333, 6224.37756224374, 6257.1552840367785, 6267.4045965633195, 6284.0], "value": 4976.389057297404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.7948461596142, 913.5843191347941, 941.4821847983608, 943.6414162618204, 945.5933948402186, 17774.555636109104, 18045.09774511274, 18156.0, 18164.636707265847, 18289.359872404468, 18267.269309227617, 18306.0, 18335.54161145972, 18409.07954602268, 18483.445496635122, 949.8100379924026, 956.2159029595734, 956.6030097509525, 960.2941837749248, 960.865478832964, 964.5755867418349, 973.177664873181, 977.4477420257567, 977.9706608801712, 978.6623614852864, 966.096699585886, 1021.2646894236138, 1029.963951261706, 1034.5913364221128, 1041.6927006533053, 1013.2350075692841, 1018.9643362482315, 1020.6274709730969, 1021.9284650074497, 1033.5968972100811, 738.7008261654039, 742.6064185981385, 743.141671369569, 743.4349894080538, 744.3933194446563, 19407.0, 20207.797922020887, 20244.595108097903, 20297.188112475484, 20362.694559581618, 21080.5783884323, 21267.36197914065, 21542.246021389332, 21632.783672163234, 22024.008919598655, 16793.160341982853, 16985.91507042457, 17164.656706865917, 17225.827741722547, 17306.307747690076, 3771.453139294787, 3788.0719223790074, 3813.1420430403214, 3823.2735780201674, 3826.4069069294305, 104711.47644261806, 125750.37124814409, 142972.2851385747, 143309.0, 144363.0, 16996.0, 17530.824691752918, 17554.912225439046, 17636.118194090242, 17669.734953975443, 31285.687143128733, 32120.196995074843, 32171.195720107185, 32372.35255294881, 32420.83789581037, 8729.21437070654, 9008.324375671851, 9027.548622568846, 9081.77295567616, 9194.402363846462, 4126.7523948563185, 4159.459270294903, 4237.745735255895, 4247.320428731388, 4254.680898932593, 5526.281583394133, 5577.274954256002, 5605.0, 5625.521830644359, 5633.211350410946, 1057.825458799305, 1075.3171735947728, 1084.3439718970067, 1100.378286268272, 1101.8457415961773, 638.9648569328639, 657.6875983907605, 672.3276723276625, 673.1014096181555, 674.4132604634, 11770.58802941893, 11800.82298765502, 11973.102017348734, 12283.631491055283, 12392.938035309766, 689.2327305866949, 691.789004353677, 695.1102588686389, 698.2947223304398, 706.9399101076466, 5509.807156749494, 5519.227308176858, 5559.499645031967, 5565.332160140809, 5627.549796016309, 118414.40792795981, 118490.4075479617, 122124.0, 122126.0, 126441.0, 82131.5893420529, 108479.45760271148, 118834.4058279703, 124556.0, 127665.0, 103313.0, 104257.99999999849, 106301.46849265859, 107644.0, 109323.0, 12231.0, 12479.251244925334, 12509.687257818627, 12623.179493332904, 12758.872411275768, 40358.79820600878, 41179.38230926479, 41535.7923210382, 41993.79003105087, 42280.154396911275, 55963.720181398836, 56199.0, 56770.71614641901, 56775.71612142078, 57066.42933570611, 16286.429974950819, 16471.505854824376, 16560.834391655928, 16741.414050508174, 16758.245878935722, 19661.705074424182, 19889.403317900487, 19978.400647980583, 20495.0, 20616.79383206209, 16983.49049528516, 17057.658846823244, 17082.402115925885, 17139.057351845768, 17499.7375039372, 17878.28486860511, 18034.72947905756, 18139.27442902269, 18150.27398904029, 18199.636007279514, 17623.911880440515, 17852.19665115047, 17921.10394480297, 18265.360712375004, 18293.90853045726, 13018.2839943804, 13124.40940157676, 13305.401256943267, 13561.93219033938, 13840.584782456543, 13432.932835336152, 13499.190048597116, 13526.323683815966, 13558.254296013814, 13593.52422665202], "value": 9188.822383262475, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 115.0, 113.0, 115.0, 107.0, 111.0, 107.0, 115.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 131.0, 118.0, 116.0, 115.0, 151.0, 123.0, 123.0, 122.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 162.0, 164.0, 163.0, 163.0, 170.0, 170.0, 162.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 77.0, 76.0, 81.0, 83.0, 76.0, 81.0, 82.0, 81.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 89.0, 83.0, 82.0, 78.0, 81.0, 84.0, 86.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 114.0, 120.0, 120.0, 117.0, 119.0, 118.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 104.0, 95.0, 100.0, 98.0, 95.0, 96.0, 95.0, 94.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 53.0, 66.0, 56.0, 57.0, 64.0, 52.0, 55.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 47.0, 38.0, 38.0, 46.0, 37.0, 38.0, 48.0, 38.0, 38.0], "value": 41.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 73.0, 81.0, 74.0, 82.0, 80.0, 74.0, 82.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 124.0, 112.0, 126.0, 120.0, 120.0, 130.0, 120.0, 112.0, 111.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 183.0, 176.0, 172.0, 172.0, 169.0, 169.0, 170.0, 178.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 73.0, 64.0, 67.0, 64.0, 63.0, 67.0, 66.0, 72.0], "value": 66.8, "unit": "score"}]}]} 03:16:08 INFO - Return code: 0 03:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:08 INFO - # TBPL SUCCESS # 03:16:08 INFO - Running post-action listener: _package_coverage_data 03:16:08 INFO - Running post-action listener: _resource_record_post_action 03:16:08 INFO - [mozharness: 2017-09-19 10:16:08.343561Z] Finished run-tests step (success) 03:16:08 INFO - Running post-run listener: _resource_record_post_run 03:16:08 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 21037056; Write bytes: 397582336; Read time: 9532; Write time: 249188 03:16:08 INFO - TinderboxPrint: CPU usage
13.3% 03:16:08 INFO - TinderboxPrint: I/O read bytes / time
21,037,056 / 9,532 03:16:08 INFO - TinderboxPrint: I/O write bytes / time
397,582,336 / 249,188 03:16:08 INFO - TinderboxPrint: CPU idle
8,270.2 (86.7%) 03:16:08 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 03:16:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:16:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 24576; Write bytes: 73900032; Read time: 148; Write time: 14432 03:16:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:16:08 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 18657280; Write bytes: 243249152; Read time: 8880; Write time: 176180 03:16:08 INFO - Running post-run listener: _upload_blobber_files 03:16:08 INFO - Blob upload gear active. 03:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:08 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 03:16:08 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'] 03:16:08 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 03:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:10 INFO - (blobuploader) - INFO - Done attempting. 03:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:17 INFO - (blobuploader) - INFO - Done attempting. 03:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:18 INFO - (blobuploader) - INFO - Done attempting. 03:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:19 INFO - (blobuploader) - INFO - Done attempting. 03:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:19 INFO - Return code: 0 03:16:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f663199694af1e5ea2de3aa62c1b096592561b0dcffe27809b653eab0b171b3cafc8e91da4b0d40d9a55cf11c4ee7bf18d80fd075e310f9237ee8c79d10181a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5649e3f75fc54c7cf04f40033fa01899624fb81b9ddfc3b728e5c752ac40942f5a71f782cd519e63c2222fa39f3a33d945aef31bd35de42e3ca43f5827858a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85db4ffb2149e313a65cb9760b0cda78f4d9db4437302726e4f4d23402a7d3ee212f12be1b4688dab88b385ae7104c2eab1bc6faa8ecad3de10fbf8647d8f8b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c098ed1b4e45172f8f8237f2006d05ac95f76097afca730a328841b65be1b460dae2349e419c74baa3ec489944be9ce541097bd212ddc50b5962b73166114e6"} 03:16:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:19 INFO - Contents: 03:16:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f663199694af1e5ea2de3aa62c1b096592561b0dcffe27809b653eab0b171b3cafc8e91da4b0d40d9a55cf11c4ee7bf18d80fd075e310f9237ee8c79d10181a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5649e3f75fc54c7cf04f40033fa01899624fb81b9ddfc3b728e5c752ac40942f5a71f782cd519e63c2222fa39f3a33d945aef31bd35de42e3ca43f5827858a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85db4ffb2149e313a65cb9760b0cda78f4d9db4437302726e4f4d23402a7d3ee212f12be1b4688dab88b385ae7104c2eab1bc6faa8ecad3de10fbf8647d8f8b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c098ed1b4e45172f8f8237f2006d05ac95f76097afca730a328841b65be1b460dae2349e419c74baa3ec489944be9ce541097bd212ddc50b5962b73166114e6"} 03:16:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:19 INFO - Copying logs to upload dir... 03:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.141088 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-19 03:16:19.148636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:19.151560) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f663199694af1e5ea2de3aa62c1b096592561b0dcffe27809b653eab0b171b3cafc8e91da4b0d40d9a55cf11c4ee7bf18d80fd075e310f9237ee8c79d10181a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5649e3f75fc54c7cf04f40033fa01899624fb81b9ddfc3b728e5c752ac40942f5a71f782cd519e63c2222fa39f3a33d945aef31bd35de42e3ca43f5827858a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85db4ffb2149e313a65cb9760b0cda78f4d9db4437302726e4f4d23402a7d3ee212f12be1b4688dab88b385ae7104c2eab1bc6faa8ecad3de10fbf8647d8f8b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c098ed1b4e45172f8f8237f2006d05ac95f76097afca730a328841b65be1b460dae2349e419c74baa3ec489944be9ce541097bd212ddc50b5962b73166114e6"} build_url:https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f663199694af1e5ea2de3aa62c1b096592561b0dcffe27809b653eab0b171b3cafc8e91da4b0d40d9a55cf11c4ee7bf18d80fd075e310f9237ee8c79d10181a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5649e3f75fc54c7cf04f40033fa01899624fb81b9ddfc3b728e5c752ac40942f5a71f782cd519e63c2222fa39f3a33d945aef31bd35de42e3ca43f5827858a6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85db4ffb2149e313a65cb9760b0cda78f4d9db4437302726e4f4d23402a7d3ee212f12be1b4688dab88b385ae7104c2eab1bc6faa8ecad3de10fbf8647d8f8b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c098ed1b4e45172f8f8237f2006d05ac95f76097afca730a328841b65be1b460dae2349e419c74baa3ec489944be9ce541097bd212ddc50b5962b73166114e6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:19.191586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:19.196031) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505814280.567980-530300056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:19.254470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:16:19.255153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:16:19.255810) ========= ========= Total master_lag: 0.66 =========