builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1506423150.4 results: success (0) revision: bc56729898954e32d3a3731d03d178ed78924c33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.404578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.405044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.405332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.467666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.468023) ========= 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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 03:52:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-09-26 03:52:30 (69.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.641179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.641462) ========= 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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020804 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.702325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:30.702634) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc56729898954e32d3a3731d03d178ed78924c33 --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 bc56729898954e32d3a3731d03d178ed78924c33 --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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 03:52:30,787 truncating revision to first 12 chars 2017-09-26 03:52:30,787 Setting DEBUG logging. 2017-09-26 03:52:30,787 attempt 1/10 2017-09-26 03:52:30,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc5672989895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 03:52:31,040 unpacking tar archive at: mozilla-central-bc5672989895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572236 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:31.307079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:31.307387) ========= script_repo_revision: bc56729898954e32d3a3731d03d178ed78924c33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:31.307806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:31.308088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 03:52:31.323937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-26 03:52:31.324203) ========= /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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:31 INFO - MultiFileLogger online at 20170926 03:52:31 in /builds/slave/test 03:52:31 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 03:52:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:31 INFO - {'append_to_log': False, 03:52:31 INFO - 'base_work_dir': '/builds/slave/test', 03:52:31 INFO - 'blob_upload_branch': 'Firefox', 03:52:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:31 INFO - 'branch': 'Firefox', 03:52:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:31 INFO - 'code_coverage': False, 03:52:31 INFO - 'config_files': ('talos/linux_config.py',), 03:52:31 INFO - 'default_actions': ('clobber', 03:52:31 INFO - 'read-buildbot-config', 03:52:31 INFO - 'download-and-extract', 03:52:31 INFO - 'populate-webroot', 03:52:31 INFO - 'create-virtualenv', 03:52:31 INFO - 'install', 03:52:31 INFO - 'setup-mitmproxy', 03:52:31 INFO - 'run-tests'), 03:52:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:31 INFO - 'disable_ccov_upload': False, 03:52:31 INFO - 'disable_stylo': False, 03:52:31 INFO - 'download_minidump_stackwalk': True, 03:52:31 INFO - 'download_symbols': 'ondemand', 03:52:31 INFO - 'enable_stylo': False, 03:52:31 INFO - 'enable_webrender': False, 03:52:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:52:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:31 INFO - 'gecko_profile': False, 03:52:31 INFO - 'gecko_profile_interval': 0, 03:52:31 INFO - 'installer_path': 'installer.exe', 03:52:31 INFO - 'log_level': 'info', 03:52:31 INFO - 'log_name': 'talos', 03:52:31 INFO - 'log_to_console': True, 03:52:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:31 INFO - 'opt_config_files': (), 03:52:31 INFO - 'pip_index': False, 03:52:31 INFO - 'suite': 'dromaeojs-e10s', 03:52:31 INFO - 'system_bits': '32', 03:52:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:31 INFO - 'title': 'talos-linux64-ix-003', 03:52:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:31 INFO - 'use_talos_json': True, 03:52:31 INFO - 'verify': 'False', 03:52:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:31 INFO - 'work_dir': 'build'} 03:52:31 INFO - [mozharness: 2017-09-26 10:52:31.537179Z] Running clobber step. 03:52:31 INFO - Running pre-action listener: _resource_record_pre_action 03:52:31 INFO - Running main action method: clobber 03:52:31 INFO - rmtree: /builds/slave/test/build 03:52:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:33 INFO - Running post-action listener: _resource_record_post_action 03:52:33 INFO - [mozharness: 2017-09-26 10:52:33.039577Z] Finished clobber step (success) 03:52:33 INFO - [mozharness: 2017-09-26 10:52:33.039674Z] Running read-buildbot-config step. 03:52:33 INFO - Running pre-action listener: _resource_record_pre_action 03:52:33 INFO - Running main action method: read_buildbot_config 03:52:33 INFO - Using buildbot properties: 03:52:33 INFO - { 03:52:33 INFO - "project": "", 03:52:33 INFO - "product": "firefox", 03:52:33 INFO - "who": "archaeopteryx@coole-files.de", 03:52:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:52:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:52:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:52:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:52:33 INFO - "stage_platform": "linux64-qr", 03:52:33 INFO - "basedir": "/builds/slave/test", 03:52:33 INFO - "buildnumber": 83, 03:52:33 INFO - "platform": "ubuntu64_hw_qr", 03:52:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:52:33 INFO - "slavebuilddir": "test", 03:52:33 INFO - "taskId": "Psbr3YlCR5W_oxUNfATznA", 03:52:33 INFO - "branch": "mozilla-central", 03:52:33 INFO - "script_repo_revision": "production", 03:52:33 INFO - "revision": "bc56729898954e32d3a3731d03d178ed78924c33", 03:52:33 INFO - "slavename": "talos-linux64-ix-003", 03:52:33 INFO - "repo_path": "mozilla-central" 03:52:33 INFO - } 03:52:33 INFO - Finding installer, test and symbols from parent task. 03:52:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Psbr3YlCR5W_oxUNfATznA'}, attempt #1 03:52:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Psbr3YlCR5W_oxUNfATznA'}, attempt #1 03:52:33 INFO - Task dependencies: PCiGiK1VQh2s6A_KoXCpVQ 03:52:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ'}, attempt #1 03:52:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 03:52:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.test_packages.json 03:52:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.crashreporter-symbols.zip 03:52:34 INFO - Running post-action listener: _resource_record_post_action 03:52:34 INFO - [mozharness: 2017-09-26 10:52:34.386002Z] Finished read-buildbot-config step (success) 03:52:34 INFO - [mozharness: 2017-09-26 10:52:34.386221Z] Running download-and-extract step. 03:52:34 INFO - Running pre-action listener: _resource_record_pre_action 03:52:34 INFO - Running main action method: download_and_extract 03:52:34 INFO - mkdir: /builds/slave/test/build/tests 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:34 INFO - trying https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.test_packages.json 03:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:52:34 INFO - Downloaded 989 bytes. 03:52:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:52:34 INFO - Using the following test package requirements: 03:52:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:52:34 INFO - u'common': [u'target.common.tests.zip'], 03:52:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:52:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:52:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:52:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:52:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:52:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:52:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:52:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:52:34 INFO - u'target.web-platform.tests.tar.gz'], 03:52:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:52:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:52:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.common.tests.zip 03:52:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:34 INFO - Fetch https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.common.tests.zip into memory 03:52:36 INFO - Content-Length response header: 54943935 03:52:36 INFO - Bytes received: 54943935 03:52:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.talos.tests.zip 03:52:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.talos.tests.zip into memory 03:52:47 INFO - Content-Length response header: 14513823 03:52:47 INFO - Bytes received: 14513823 03:52:48 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')]} 03:52:48 INFO - trying https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 03:52:48 INFO - Downloading https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:50 INFO - Downloaded 61569205 bytes. 03:52:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 03:52:50 INFO - mkdir: /builds/slave/test/properties 03:52:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:50 INFO - Contents: 03:52:50 INFO - build_url:https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 03:52:50 INFO - Running post-action listener: _resource_record_post_action 03:52:50 INFO - Running post-action listener: find_tests_for_verification 03:52:50 INFO - Running post-action listener: set_extra_try_arguments 03:52:50 INFO - [mozharness: 2017-09-26 10:52:50.697935Z] Finished download-and-extract step (success) 03:52:50 INFO - [mozharness: 2017-09-26 10:52:50.698036Z] Running populate-webroot step. 03:52:50 INFO - Running pre-action listener: _resource_record_pre_action 03:52:50 INFO - Running main action method: populate_webroot 03:52:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['tresize', 03:52:50 INFO - 'tcanvasmark']}, 03:52:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['dromaeo_css', 03:52:50 INFO - 'kraken']}, 03:52:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'tests': ['damp', 'tps']}, 03:52:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['damp', 'tps']}, 03:52:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['dromaeo_dom']}, 03:52:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['basic_compositor_video', 03:52:50 INFO - 'glvideo']}, 03:52:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:52:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['ts_paint_webext', 03:52:50 INFO - 'tp5o_webext']}, 03:52:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:50 INFO - 'ts_paint', 03:52:50 INFO - 'tpaint', 03:52:50 INFO - 'sessionrestore', 03:52:50 INFO - 'sessionrestore_many_windows', 03:52:50 INFO - 'sessionrestore_no_auto_restore', 03:52:50 INFO - 'tabpaint']}, 03:52:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['a11yr', 03:52:50 INFO - 'ts_paint', 03:52:50 INFO - 'tpaint', 03:52:50 INFO - 'sessionrestore', 03:52:50 INFO - 'sessionrestore_many_windows', 03:52:50 INFO - 'sessionrestore_no_auto_restore', 03:52:50 INFO - 'tabpaint']}, 03:52:50 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:52:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:52:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['perf_reftest_singletons']}, 03:52:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['perf_reftest']}, 03:52:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:50 INFO - 'tsvgr_opacity', 03:52:50 INFO - 'tart', 03:52:50 INFO - 'tscrollx', 03:52:50 INFO - 'tsvg_static']}, 03:52:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['tsvgx', 03:52:50 INFO - 'tsvgr_opacity', 03:52:50 INFO - 'tart', 03:52:50 INFO - 'tscrollx', 03:52:50 INFO - 'tsvg_static']}, 03:52:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--disable-stylo'], 03:52:50 INFO - 'tests': ['tp5o']}, 03:52:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:52:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:52:50 INFO - 'talos_options': ['--mitmproxy', 03:52:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:52:50 INFO - '--firstNonBlankPaint'], 03:52:50 INFO - 'tests': ['tp6_google', 03:52:50 INFO - 'tp6_youtube', 03:52:50 INFO - 'tp6_amazon', 03:52:50 INFO - 'tp6_facebook']}, 03:52:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:52:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:52:50 INFO - 'talos_options': ['--disable-stylo', 03:52:50 INFO - '--mitmproxy', 03:52:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:52:50 INFO - '--firstNonBlankPaint'], 03:52:50 INFO - 'tests': ['tp6_google', 03:52:50 INFO - 'tp6_youtube', 03:52:50 INFO - 'tp6_amazon', 03:52:50 INFO - 'tp6_facebook']}, 03:52:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:52:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:52:50 INFO - 'talos_options': ['--stylo-threads=1', 03:52:50 INFO - '--mitmproxy', 03:52:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:52:50 INFO - '--firstNonBlankPaint'], 03:52:50 INFO - 'tests': ['tp6_google', 03:52:50 INFO - 'tp6_youtube', 03:52:50 INFO - 'tp6_amazon', 03:52:50 INFO - 'tp6_facebook']}, 03:52:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--xperf_path', 03:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:50 INFO - 'tests': ['tp5n']}, 03:52:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:52:50 INFO - 'talos_options': ['--disable-stylo', 03:52:50 INFO - '--xperf_path', 03:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:50 INFO - 'tests': ['tp5n']}}} 03:52:50 INFO - Running post-action listener: _resource_record_post_action 03:52:50 INFO - [mozharness: 2017-09-26 10:52:50.722069Z] Finished populate-webroot step (success) 03:52:50 INFO - [mozharness: 2017-09-26 10:52:50.722160Z] Running create-virtualenv step. 03:52:50 INFO - Running pre-action listener: _resource_record_pre_action 03:52:50 INFO - Running main action method: create_virtualenv 03:52:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:52:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:52:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:52:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:51 INFO - Installing pip...............done. 03:52:51 INFO - Return code: 0 03:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:51 INFO - Reading from file tmpfile_stdout 03:52:51 INFO - Output received: 03:52: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) 03:52:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52: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 03:52: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 03:52:51 INFO - Using env: {'DISPLAY': ':0', 03:52:51 INFO - 'HOME': '/home/cltbld', 03:52:51 INFO - 'LANG': 'en_US.UTF-8', 03:52:51 INFO - 'LANGUAGE': 'en_US:en', 03:52:51 INFO - 'LOGNAME': 'cltbld', 03:52:51 INFO - 'MAIL': '/var/mail/cltbld', 03:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:51 INFO - 'MOZ_NO_REMOTE': '1', 03:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:51 INFO - 'NO_EM_RESTART': '1', 03:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:51 INFO - 'PWD': '/builds/slave/test', 03:52:51 INFO - 'SHELL': '/bin/bash', 03:52:51 INFO - 'SHLVL': '1', 03:52:51 INFO - 'TERM': 'linux', 03:52:51 INFO - 'TMOUT': '86400', 03:52:51 INFO - 'USER': 'cltbld', 03:52:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:51 INFO - '_': '/tools/buildbot/bin/python'} 03:52:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:52:52 INFO - Downloading/unpacking pip>=1.5 03:52:52 INFO - Running setup.py egg_info for package pip 03:52:52 INFO - warning: no files found matching 'pip/cacert.pem' 03:52:52 INFO - warning: no files found matching '*.html' under directory 'docs' 03:52:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:52:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:52:52 INFO - Installing collected packages: pip 03:52:52 INFO - Found existing installation: pip 1.1 03:52:52 INFO - Uninstalling pip: 03:52:52 INFO - Successfully uninstalled pip 03:52:52 INFO - Running setup.py install for pip 03:52:52 INFO - warning: no files found matching 'pip/cacert.pem' 03:52:52 INFO - warning: no files found matching '*.html' under directory 'docs' 03:52:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:52:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:52:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:52:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:52:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:52:52 INFO - Successfully installed pip 03:52:52 INFO - Cleaning up... 03:52:52 INFO - Return code: 0 03:52:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52: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 03:52: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 03:52:52 INFO - Using env: {'DISPLAY': ':0', 03:52:52 INFO - 'HOME': '/home/cltbld', 03:52:52 INFO - 'LANG': 'en_US.UTF-8', 03:52:52 INFO - 'LANGUAGE': 'en_US:en', 03:52:52 INFO - 'LOGNAME': 'cltbld', 03:52:52 INFO - 'MAIL': '/var/mail/cltbld', 03:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:52 INFO - 'MOZ_NO_REMOTE': '1', 03:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:52 INFO - 'NO_EM_RESTART': '1', 03:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:52 INFO - 'PWD': '/builds/slave/test', 03:52:52 INFO - 'SHELL': '/bin/bash', 03:52:52 INFO - 'SHLVL': '1', 03:52:52 INFO - 'TERM': 'linux', 03:52:52 INFO - 'TMOUT': '86400', 03:52:52 INFO - 'USER': 'cltbld', 03:52:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:52 INFO - '_': '/tools/buildbot/bin/python'} 03:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:53 INFO - Downloading/unpacking psutil>=3.1.1 03:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:54 INFO - Installing collected packages: psutil 03:52:54 INFO - Running setup.py install for psutil 03:52:54 INFO - building 'psutil._psutil_linux' extension 03:52: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 03:52:54 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 03:52:54 INFO - building 'psutil._psutil_posix' extension 03:52:54 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 03:52:54 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 03:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:54 INFO - Successfully installed psutil 03:52:54 INFO - Cleaning up... 03:52:54 INFO - Return code: 0 03:52:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:52:54 INFO - Using env: {'DISPLAY': ':0', 03:52:54 INFO - 'HOME': '/home/cltbld', 03:52:54 INFO - 'LANG': 'en_US.UTF-8', 03:52:54 INFO - 'LANGUAGE': 'en_US:en', 03:52:54 INFO - 'LOGNAME': 'cltbld', 03:52:54 INFO - 'MAIL': '/var/mail/cltbld', 03:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:54 INFO - 'MOZ_NO_REMOTE': '1', 03:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:54 INFO - 'NO_EM_RESTART': '1', 03:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:54 INFO - 'PWD': '/builds/slave/test', 03:52:54 INFO - 'SHELL': '/bin/bash', 03:52:54 INFO - 'SHLVL': '1', 03:52:54 INFO - 'TERM': 'linux', 03:52:54 INFO - 'TMOUT': '86400', 03:52:54 INFO - 'USER': 'cltbld', 03:52:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:54 INFO - '_': '/tools/buildbot/bin/python'} 03:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:56 INFO - Installing collected packages: mozsystemmonitor 03:52:56 INFO - Running setup.py install for mozsystemmonitor 03:52:56 INFO - Successfully installed mozsystemmonitor 03:52:56 INFO - Cleaning up... 03:52:57 INFO - Return code: 0 03:52:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52: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 03:52: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 03:52:57 INFO - Using env: {'DISPLAY': ':0', 03:52:57 INFO - 'HOME': '/home/cltbld', 03:52:57 INFO - 'LANG': 'en_US.UTF-8', 03:52:57 INFO - 'LANGUAGE': 'en_US:en', 03:52:57 INFO - 'LOGNAME': 'cltbld', 03:52:57 INFO - 'MAIL': '/var/mail/cltbld', 03:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:57 INFO - 'MOZ_NO_REMOTE': '1', 03:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:57 INFO - 'NO_EM_RESTART': '1', 03:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:57 INFO - 'PWD': '/builds/slave/test', 03:52:57 INFO - 'SHELL': '/bin/bash', 03:52:57 INFO - 'SHLVL': '1', 03:52:57 INFO - 'TERM': 'linux', 03:52:57 INFO - 'TMOUT': '86400', 03:52:57 INFO - 'USER': 'cltbld', 03:52:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:57 INFO - '_': '/tools/buildbot/bin/python'} 03:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:52: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 03:52: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 03:52: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 03:52: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 03:52:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52: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 03:52: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 03:52: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 03:52: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 03:52:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:59 INFO - warning: no files found matching '*.txt' 03:52:59 INFO - no previously-included directories found matching 'build' 03:52:59 INFO - no previously-included directories found matching 'dist' 03:52:59 INFO - no previously-included directories found matching '.git*' 03:52:59 INFO - Installing collected packages: jsonschema, functools32 03:52:59 INFO - Running setup.py install for functools32 03:52:59 INFO - warning: no files found matching '*.txt' 03:52:59 INFO - no previously-included directories found matching 'build' 03:52:59 INFO - no previously-included directories found matching 'dist' 03:52:59 INFO - no previously-included directories found matching '.git*' 03:52:59 INFO - Successfully installed jsonschema functools32 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52: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 03:52: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 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:52: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 03:52: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 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:52: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 03:52: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 03:52: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 03:52: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 03:53:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53: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 03:53: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 03:53: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 03:53: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 03:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53: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 03:53: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 03:53: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 03:53: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 03:53:01 INFO - Downloading docopt-0.6.1.tar.gz 03:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:01 INFO - Running setup.py install for blobuploader 03:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:01 INFO - Running setup.py install for requests 03:53:02 INFO - Running setup.py install for docopt 03:53:02 INFO - Successfully installed blobuploader requests docopt 03:53:02 INFO - Cleaning up... 03:53:02 INFO - Return code: 0 03:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:53:02 INFO - Using env: {'DISPLAY': ':0', 03:53:02 INFO - 'HOME': '/home/cltbld', 03:53:02 INFO - 'LANG': 'en_US.UTF-8', 03:53:02 INFO - 'LANGUAGE': 'en_US:en', 03:53:02 INFO - 'LOGNAME': 'cltbld', 03:53:02 INFO - 'MAIL': '/var/mail/cltbld', 03:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:02 INFO - 'MOZ_NO_REMOTE': '1', 03:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:02 INFO - 'NO_EM_RESTART': '1', 03:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:02 INFO - 'PWD': '/builds/slave/test', 03:53:02 INFO - 'SHELL': '/bin/bash', 03:53:02 INFO - 'SHLVL': '1', 03:53:02 INFO - 'TERM': 'linux', 03:53:02 INFO - 'TMOUT': '86400', 03:53:02 INFO - 'USER': 'cltbld', 03:53:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:02 INFO - '_': '/tools/buildbot/bin/python'} 03:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:02 INFO - Running setup.py (path:/tmp/pip-qvk0JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:02 INFO - Running setup.py (path:/tmp/pip-THFAZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:02 INFO - Running setup.py (path:/tmp/pip-SB7E28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:02 INFO - Running setup.py (path:/tmp/pip-ATJx3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:02 INFO - Running setup.py (path:/tmp/pip-1a9DZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:02 INFO - Running setup.py (path:/tmp/pip-batJfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:02 INFO - Running setup.py (path:/tmp/pip-8ow8vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:02 INFO - Running setup.py (path:/tmp/pip-zdf0Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:02 INFO - Running setup.py (path:/tmp/pip-0fdd0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:03 INFO - Running setup.py (path:/tmp/pip-9gJDVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:03 INFO - Running setup.py (path:/tmp/pip-w_xF74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:03 INFO - Running setup.py (path:/tmp/pip-fq6taq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:03 INFO - Running setup.py (path:/tmp/pip-ClJHG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:03 INFO - Running setup.py (path:/tmp/pip-zFuaj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:03 INFO - Running setup.py (path:/tmp/pip-4aGMCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:03 INFO - Running setup.py (path:/tmp/pip-Ki4h4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:03 INFO - Running setup.py (path:/tmp/pip-v99pfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:03 INFO - Running setup.py install for manifestparser 03:53:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:03 INFO - Running setup.py install for mozcrash 03:53:03 INFO - Running setup.py install for mozdebug 03:53:03 INFO - Running setup.py install for mozdevice 03:53:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozfile 03:53:04 INFO - Running setup.py install for mozhttpd 03:53:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozinfo 03:53:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozInstall 03:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozleak 03:53:04 INFO - Running setup.py install for mozlog 03:53:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for moznetwork 03:53:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozprocess 03:53:04 INFO - Running setup.py install for mozprofile 03:53:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:04 INFO - Running setup.py install for mozrunner 03:53:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:05 INFO - Running setup.py install for mozscreenshot 03:53:05 INFO - Running setup.py install for moztest 03:53:05 INFO - Running setup.py install for mozversion 03:53:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:05 INFO - Cleaning up... 03:53:05 INFO - Return code: 0 03:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:53: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 03:53: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 03:53:05 INFO - Using env: {'DISPLAY': ':0', 03:53:05 INFO - 'HOME': '/home/cltbld', 03:53:05 INFO - 'LANG': 'en_US.UTF-8', 03:53:05 INFO - 'LANGUAGE': 'en_US:en', 03:53:05 INFO - 'LOGNAME': 'cltbld', 03:53:05 INFO - 'MAIL': '/var/mail/cltbld', 03:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:05 INFO - 'MOZ_NO_REMOTE': '1', 03:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:05 INFO - 'NO_EM_RESTART': '1', 03:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:05 INFO - 'PWD': '/builds/slave/test', 03:53:05 INFO - 'SHELL': '/bin/bash', 03:53:05 INFO - 'SHLVL': '1', 03:53:05 INFO - 'TERM': 'linux', 03:53:05 INFO - 'TMOUT': '86400', 03:53:05 INFO - 'USER': 'cltbld', 03:53:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:05 INFO - '_': '/tools/buildbot/bin/python'} 03:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:05 INFO - Running setup.py (path:/tmp/pip-TydRzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53: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)) 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:05 INFO - Running setup.py (path:/tmp/pip-SxIAKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53: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)) 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:05 INFO - Running setup.py (path:/tmp/pip-yDdtNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53: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)) 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:05 INFO - Running setup.py (path:/tmp/pip-Y1pFLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53: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)) 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:05 INFO - Running setup.py (path:/tmp/pip-lCsPaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53: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)) 03:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:06 INFO - Running setup.py (path:/tmp/pip-7wY93t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:06 INFO - Running setup.py (path:/tmp/pip-pQDzyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:06 INFO - Running setup.py (path:/tmp/pip-6HR6Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:06 INFO - Running setup.py (path:/tmp/pip-eB2bsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:06 INFO - Running setup.py (path:/tmp/pip-UvIK4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:06 INFO - Running setup.py (path:/tmp/pip-n0J9Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:06 INFO - Running setup.py (path:/tmp/pip-Y6t6A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:06 INFO - Running setup.py (path:/tmp/pip-yu5FuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:06 INFO - Running setup.py (path:/tmp/pip-KI_YiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:06 INFO - Running setup.py (path:/tmp/pip-JcAVNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:06 INFO - Running setup.py (path:/tmp/pip-NCbnrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53: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)) 03:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:06 INFO - Running setup.py (path:/tmp/pip-QmgJj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53: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 03:53: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 03:53: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 03:53: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 03:53:07 INFO - Downloading blessings-1.6.tar.gz 03:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:08 INFO - Installing collected packages: blessings 03:53:08 INFO - Running setup.py install for blessings 03:53:08 INFO - Successfully installed blessings 03:53:08 INFO - Cleaning up... 03:53:08 INFO - Return code: 0 03:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:08 INFO - Reading from file tmpfile_stdout 03:53:08 INFO - Current package versions: 03:53:08 INFO - argparse == 1.2.1 03:53:08 INFO - blessings == 1.6 03:53:08 INFO - blobuploader == 1.2.4 03:53:08 INFO - docopt == 0.6.1 03:53:08 INFO - functools32 == 3.2.3-2 03:53:08 INFO - jsonschema == 2.5.1 03:53:08 INFO - manifestparser == 1.1 03:53:08 INFO - mozInstall == 1.13 03:53:08 INFO - mozcrash == 1.0 03:53:08 INFO - mozdebug == 0.1 03:53:08 INFO - mozdevice == 0.51 03:53:08 INFO - mozfile == 1.2 03:53:08 INFO - mozhttpd == 0.7 03:53:08 INFO - mozinfo == 0.10 03:53:08 INFO - mozleak == 0.1 03:53:08 INFO - mozlog == 3.5 03:53:08 INFO - moznetwork == 0.27 03:53:08 INFO - mozprocess == 0.25 03:53:08 INFO - mozprofile == 0.28 03:53:08 INFO - mozrunner == 6.13 03:53:08 INFO - mozscreenshot == 0.1 03:53:08 INFO - mozsystemmonitor == 0.3 03:53:08 INFO - moztest == 0.8 03:53:08 INFO - mozversion == 1.4 03:53:08 INFO - psutil == 3.1.1 03:53:08 INFO - requests == 1.2.3 03:53:08 INFO - wsgiref == 0.1.2 03:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:53: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 03:53: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 03:53:08 INFO - Using env: {'DISPLAY': ':0', 03:53:08 INFO - 'HOME': '/home/cltbld', 03:53:08 INFO - 'LANG': 'en_US.UTF-8', 03:53:08 INFO - 'LANGUAGE': 'en_US:en', 03:53:08 INFO - 'LOGNAME': 'cltbld', 03:53:08 INFO - 'MAIL': '/var/mail/cltbld', 03:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:08 INFO - 'MOZ_NO_REMOTE': '1', 03:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:08 INFO - 'NO_EM_RESTART': '1', 03:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:08 INFO - 'PWD': '/builds/slave/test', 03:53:08 INFO - 'SHELL': '/bin/bash', 03:53:08 INFO - 'SHLVL': '1', 03:53:08 INFO - 'TERM': 'linux', 03:53:08 INFO - 'TMOUT': '86400', 03:53:08 INFO - 'USER': 'cltbld', 03:53:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:08 INFO - '_': '/tools/buildbot/bin/python'} 03:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53: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)) 03:53:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:53: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 03:53: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 03:53: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 03:53: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 03:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:53: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)) 03:53: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)) 03:53:09 INFO - Installing collected packages: simplejson 03:53:09 INFO - Running setup.py install for simplejson 03:53:09 INFO - building 'simplejson._speedups' extension 03:53: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 03:53: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 03:53:10 INFO - Successfully installed simplejson 03:53:10 INFO - Cleaning up... 03:53:10 INFO - Return code: 0 03:53:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53: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 0x1ec81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2090b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22359c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, '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': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', '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 03:53: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 03:53: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 03:53:10 INFO - Using env: {'DISPLAY': ':0', 03:53:10 INFO - 'HOME': '/home/cltbld', 03:53:10 INFO - 'LANG': 'en_US.UTF-8', 03:53:10 INFO - 'LANGUAGE': 'en_US:en', 03:53:10 INFO - 'LOGNAME': 'cltbld', 03:53:10 INFO - 'MAIL': '/var/mail/cltbld', 03:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:10 INFO - 'MOZ_NO_REMOTE': '1', 03:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:10 INFO - 'NO_EM_RESTART': '1', 03:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:10 INFO - 'PWD': '/builds/slave/test', 03:53:10 INFO - 'SHELL': '/bin/bash', 03:53:10 INFO - 'SHLVL': '1', 03:53:10 INFO - 'TERM': 'linux', 03:53:10 INFO - 'TMOUT': '86400', 03:53:10 INFO - 'USER': 'cltbld', 03:53:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:10 INFO - '_': '/tools/buildbot/bin/python'} 03:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:11 INFO - Cleaning up... 03:53:11 INFO - Return code: 0 03:53:11 INFO - Running post-action listener: _resource_record_post_action 03:53:11 INFO - Running post-action listener: _start_resource_monitoring 03:53:11 INFO - Starting resource monitoring. 03:53:11 INFO - [mozharness: 2017-09-26 10:53:11.115816Z] Finished create-virtualenv step (success) 03:53:11 INFO - [mozharness: 2017-09-26 10:53:11.116338Z] Running install step. 03:53:11 INFO - Running pre-action listener: _resource_record_pre_action 03:53:11 INFO - Running main action method: install 03:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:11 INFO - Reading from file tmpfile_stdout 03:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:11 INFO - Reading from file tmpfile_stdout 03:53:11 INFO - Output received: 03:53:11 INFO - Usage: mozinstall [options] installer 03:53:11 INFO - Options: 03:53:11 INFO - -h, --help show this help message and exit 03:53:11 INFO - -d DEST, --destination=DEST 03:53:11 INFO - Directory to install application into. [default: 03:53:11 INFO - "/builds/slave/test"] 03:53:11 INFO - --app=APP Application being installed. [default: firefox] 03:53:11 INFO - mkdir: /builds/slave/test/build/application 03:53: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'] 03:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:53:29 INFO - Reading from file tmpfile_stdout 03:53:29 INFO - Output received: 03:53:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:29 INFO - Running post-action listener: _resource_record_post_action 03:53:29 INFO - [mozharness: 2017-09-26 10:53:29.222725Z] Finished install step (success) 03:53:29 INFO - [mozharness: 2017-09-26 10:53:29.223070Z] Running setup-mitmproxy step. 03:53:29 INFO - Running pre-action listener: _resource_record_pre_action 03:53:29 INFO - Running main action method: setup_mitmproxy 03:53:29 INFO - Skipping: mitmproxy is not required 03:53:29 INFO - Running post-action listener: _resource_record_post_action 03:53:29 INFO - [mozharness: 2017-09-26 10:53:29.224694Z] Finished setup-mitmproxy step (success) 03:53:29 INFO - [mozharness: 2017-09-26 10:53:29.225010Z] Running run-tests step. 03:53:29 INFO - Running pre-action listener: _resource_record_pre_action 03:53:29 INFO - Running pre-action listener: _set_gcov_prefix 03:53:29 INFO - Running main action method: run_tests 03:53:29 WARNING - Try message not found. 03:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:29 INFO - Python 2.7.3 03:53:29 INFO - Return code: 0 03:53:29 INFO - grabbing minidump binary from tooltool 03:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232d60>, '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 0x2233a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2233ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:53:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:53:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:53:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:29 INFO - Return code: 0 03:53:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:29 INFO - ENV: RUST_BACKTRACE is now full 03:53:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53: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/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 03:53: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/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 03:53:29 INFO - Using env: {'DISPLAY': ':0', 03:53:29 INFO - 'HOME': '/home/cltbld', 03:53:29 INFO - 'LANG': 'en_US.UTF-8', 03:53:29 INFO - 'LANGUAGE': 'en_US:en', 03:53:29 INFO - 'LOGNAME': 'cltbld', 03:53:29 INFO - 'MAIL': '/var/mail/cltbld', 03:53:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:29 INFO - 'MOZ_ACCELERATED': '1', 03:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:29 INFO - 'MOZ_NO_REMOTE': '1', 03:53:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:29 INFO - 'MOZ_WEBRENDER': '1', 03:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:29 INFO - 'NO_EM_RESTART': '1', 03:53:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:29 INFO - 'PWD': '/builds/slave/test', 03:53:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:29 INFO - 'RUST_BACKTRACE': 'full', 03:53:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:53:29 INFO - 'SHELL': '/bin/bash', 03:53:29 INFO - 'SHLVL': '1', 03:53:29 INFO - 'TERM': 'linux', 03:53:29 INFO - 'TMOUT': '86400', 03:53:29 INFO - 'USER': 'cltbld', 03:53:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:29 INFO - '_': '/tools/buildbot/bin/python'} 03:53: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/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 03:53:29 INFO - mozversion application_buildid: 20170926095452 03:53:29 INFO - mozversion application_changeset: bc56729898954e32d3a3731d03d178ed78924c33 03:53:29 INFO - mozversion application_display_name: Nightly 03:53:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:29 INFO - mozversion application_name: Firefox 03:53:29 INFO - mozversion application_remotingname: firefox 03:53:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:29 INFO - mozversion application_vendor: Mozilla 03:53:29 INFO - mozversion application_version: 58.0a1 03:53:29 INFO - mozversion platform_buildid: 20170926095452 03:53:29 INFO - mozversion platform_changeset: bc56729898954e32d3a3731d03d178ed78924c33 03:53:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:29 INFO - mozversion platform_version: 58.0a1 03:53:29 INFO - using testdate: 1506423209 03:53:29 INFO - actual date: 1506423209 03:53:29 INFO - starting webserver on 'localhost:36618' 03:53:29 INFO - SUITE-START | Running 2 tests 03:53:29 INFO - TEST-START | dromaeo_css 03:53:29 INFO - Initialising browser for dromaeo_css test... 03:53:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36618/getInfo.html -profile /tmp/tmpmmENO5/profile 03:53:29 INFO - TEST-INFO | started process 11346 (/builds/slave/test/build/application/firefox/firefox http://localhost:36618/getInfo.html) 03:53:37 INFO - TEST-INFO | 11346: exit 0 03:53:37 INFO - Browser initialized. 03:53:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:37 INFO - Using env: {'DISPLAY': ':0', 03:53:37 INFO - 'HOME': '/home/cltbld', 03:53:37 INFO - 'JSGC_DISABLE_POISONING': '1', 03:53:37 INFO - 'LANG': 'en_US.UTF-8', 03:53:37 INFO - 'LANGUAGE': 'en_US:en', 03:53:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:53:37 INFO - 'LOGNAME': 'cltbld', 03:53:37 INFO - 'MAIL': '/var/mail/cltbld', 03:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:37 INFO - 'MOZ_ACCELERATED': '1', 03:53:37 INFO - 'MOZ_CRASHREPORTER': '1', 03:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:53:37 INFO - 'MOZ_NO_REMOTE': '1', 03:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:37 INFO - 'MOZ_WEBRENDER': '1', 03:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:37 INFO - 'NO_EM_RESTART': '1', 03:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:37 INFO - 'PWD': '/builds/slave/test', 03:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:37 INFO - 'RUST_BACKTRACE': 'full', 03:53:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:53:37 INFO - 'SHELL': '/bin/bash', 03:53:37 INFO - 'SHLVL': '1', 03:53:37 INFO - 'TERM': 'linux', 03:53:37 INFO - 'TMOUT': '86400', 03:53:37 INFO - 'USER': 'cltbld', 03:53:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 03:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:37 INFO - '_': '/tools/buildbot/bin/python'} 03:53:37 INFO - TEST-INFO | started process 11593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmmENO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:37 INFO - PID 11593 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:53:38 INFO - PID 11593 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:53:38 INFO - PID 11593 | 03:53:38 INFO - PID 11593 | (/builds/slave/test/build/application/firefox/firefox:11653): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:38 INFO - PID 11593 | 03:53:48 INFO - PID 11593 | RSS: Main: 194007040 03:53:48 INFO - PID 11593 | 03:56:46 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36618/tests/dromaeo/cssquery-ext.html) 03:56:47 INFO - PID 11593 | RSS: Main: 196030464 03:56:47 INFO - PID 11593 | 03:59:49 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-ext.html (next: http://localhost:36618/tests/dromaeo/cssquery-jquery.html) 03:59:50 INFO - PID 11593 | RSS: Main: 196538368 03:59:50 INFO - PID 11593 | 04:02:52 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36618/tests/dromaeo/cssquery-mootools.html) 04:02:53 INFO - PID 11593 | RSS: Main: 196149248 04:02:53 INFO - PID 11593 | 04:05:55 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36618/tests/dromaeo/cssquery-prototype.html) 04:05:55 INFO - PID 11593 | RSS: Main: 200884224 04:05:55 INFO - PID 11593 | 04:08:59 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36618/tests/dromaeo/cssquery-yui.html) 04:09:00 INFO - PID 11593 | RSS: Main: 198352896 04:09:00 INFO - PID 11593 | 04:12:01 INFO - PID 11593 | Cycle 1(1): loaded http://localhost:36618/tests/dromaeo/cssquery-yui.html (next: http://localhost:36618/tests/dromaeo/cssquery-dojo.html) 04:12:02 INFO - PID 11593 | RSS: Main: 201490432 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | __start_tp_report 04:12:02 INFO - PID 11593 | _x_x_mozilla_page_load 04:12:02 INFO - PID 11593 | _x_x_mozilla_page_load_details 04:12:02 INFO - PID 11593 | |i|pagename|runs| 04:12:02 INFO - PID 11593 | |0;dojo.html;3091.969080309199;3104.3636054608805;3135.2788858562535;3184.2357834119816;3186.1238159506133;6083.178770865932;6176.351483094272;6240.687965601719;6314.7789827356055;6365.52258580606;6170.074488826678;6220.129181914524;6240.282367527736;6240.6879656017245;6271.780487682932;5718.113692377678;5728.369879313273;5769.653820770767;5809.448102430283;5811.186433899257;5784.855378615526;5844.824655260349;5871.412858714137;5892.911606325887;5905.438983296602;850.0818981340886;5633.549316054727;5659.151127330892;5674.631148975303;5891.499222566087;5709.914351284734;5751.820876720262;5831.825045248649;5846.883062338772;5855.970720146414;5722.256106706143;5738.913916291259;5805.10020946754;5809.883802323972;5810.1865738796605;6234.594751341148;6249.656268905208;6304.905426418607;6345.809625711236;6359.8092057238355;6707.731690732365;6712.697928593225;6806.285340039274;6808.6936087876165;6823.761168359084;6744.426723728489;6783.72865085396;6827.48793840459;6828.453723702092;6856.040154378391;6060.636361818261;6102.603330783485;6175.2898416681755;6188.257409110845;6214.40963108504;6955.721771129098;6960.37356637905;6994.510384273052;7000.229974702778;7031.367176954099;6583.210014798159;6590.373914478117;6607.108040414579;6656.500762442836;6688.598684078874;6441.581297215666;6593.80218593443;6695.230048544479;6769.289224631343;6773.322667733286;6601.141851559267;6678.933210667831;6681.9331806682285;6722.66386680664;6729.49528785343;6688.966555167291;6763.492738044666;6771.289014653489;6781.796546103625;6805.591664500146;5142.51146141116;5185.040767458032;5207.71357575337;5264.842054738364;5282.2340760589495;4545.704529205591;4555.863324100283;4566.109608626352;4581.748003859753;4602.907941841145;5745.052066409079;5776.855578610568;5797.507211886952;5825.592208545361;5827.096799996008;6542.443892269211;6732.360425759545;6747.190337159573;6803.65981700913;6823.28355522663;5683.346415162309;5725.627834190847;5790.957627627067;5820.417958204146;5828.038373668382;5820.970895145497;5837.67892765902;5841.912371314434;5847.26909136358;5862.70686465675;6442.77450289247;6589.769358072444;6603.669816509156;6622.602643841385;6629.171353580802;6758.3917447428;6767.458603311723;6843.7604683835825;6863.485238607224;6868.210155831944;6316;6336.08126821599;6419.582727122722;6452.451541619015;6539.280679125388;6484.157059582224;6545.901811472737;6581.572197807127;6594.439472644879;6595.505337099641;6684.83287917806;6691.130153080068;6702.698378572878;6708.262091170065;6723.966380168264;6520.608763474207;6532.608043517404;6534.411902928759;6598.406143447113;6602.6698665067515;6450.516211284266;6484.773032943825;6498.3826536478955;6559.048937903882;6569.9343006569325;6212.875742485035;6347.904781428375;6400.51996100285;6530.151080359523;6541.6075035498025;6435.646039467687;6453.16108905858;6455.806325810233;6537.182852143482;6577.473802095917;6169.660668663087;6337.2395312562785;6367.267764207176;6410.134631824831;6445.838854028687 04:12:02 INFO - PID 11593 | |1;ext.html;855.5080828523596;857.5840717252136;887.3699673232005;912.1289168843755;914.3371055984412;39828.800855995716;41455.58544414555;41487.58512414875;41512.16975660489;41533.792331038305;37819.81090094546;37964.24071518575;38230.42654360187;38297;38302.616973830256;7303.671334789934;7401.185869554345;7410.2219266977;7421;7430.554166749986;7260.891086633678;7280.708771649128;7284.0166577512155;7286.162091359482;7358.080239970004;7329.047223860891;7902.6443810028395;8065.072516660601;8079.232472915093;8124.065732440757;7987.480813747117;7995.080565734927;8021.2379823916635;8046.476978996347;8057.315128214109;7942.205779422012;7987.520748755035;7995.920040799634;8015.919840801634;8042.959785201095;38002.23995520102;38046;38226;38492.23015539702;38492.61507384946;3503.281827225438;3534.5051692762777;3559.3059353426092;3568.3041806847673;3570.393033184365;31409.528857067162;31443.52834707481;31496.685033149603;31520;31547;5172.663776854492;5188.092083885343;5202.817901373433;5214.713190774506;5235.55497782689;190729;192356;193562;193911.0304448483;194546;48536.27195592069;48863.755681221366;48886.511134888904;48991.75504122528;49047.50952490429;52274.47725522772;52792.472075279526;53431.19853202205;53499.73250133725;53584;16225.35098596043;16371.508854734377;16426;16466.6706665866;16488.17559122039;13412.463501459832;13573.117747346589;13617.523386681616;13618.455261789615;13660.316984150753;14775.40898364075;14784.926075369554;14795.778063329059;14832;14903.105813650998;5779.566532510079;5875.148103524965;5892.852678682982;5922.822315330461;5926.1999630049395;992.2607657295362;1000.2698030437821;1002.5288114586133;1005.190821388789;1019.1337363241333;23171.53656926852;23265.06939722392;23456.179033733737;23621;23775.405614859767;1096.9341839489657;1117.9888201117885;1128.4075860173475;1128.7460321427777;1135.4493070860626;12487.375631218403;12577.93711031439;12656.620301390973;12704.745905081847;12836.743265134644;228350;230221;230663;231930;232543;44538.554614454086;45303.54696452993;45508.3173752394;52416.47583524192;53093.73453132709;1442.819647544057;1449.1087980891675;1452.3319273134266;1459.1828575997263;1459.6569806095347;26658.543527872396;26789;27117.86441067782;27213.591796122677;27814.16557503278;36900.81549592342;37484.81257593694;37526;37752.05619859525;37757.05607359838;195781;196058;196120;197247;197322;33950.830245848614;34526.65473345234;34591.13522161966;34666.306673866886;34691.47962780611;42342.78828605837;42858.357124642534;43274.35088473612;43417.78291108524;43493.3475997854;30953.845230773702;31001.8449907749;31502.842485787423;31660.208494787814;31679.36641267208;30690.07929762111;30879.69120308858;31072.378552428374;31146;31400;33991.32017359688;34679;34946.126346840516;35324.11689707778;35455.64544354523;29668.40663186681;30233.848830755705;30543;30864.691353086182;30876.073717788502;22311.553768924856;22662.886685566467;22847.657285141067;22928.31215063551;22974.310770676908 04:12:02 INFO - PID 11593 | |2;jquery.html;561.3768716724438;582.871768210994;590.1472372421853;599.9010163323052;618.4557589321397;21759.67360489592;22376.552468950613;22624.43438914026;22708;22725.772742272573;22872.88563557184;24117.51764964704;24347.87826060867;24602.630960535607;24612.384690382703;6440.677966101688;6565.474762019027;6619.702113404908;6621.635810030446;6631;6440.710168042449;6504.544681872271;6539.836504087412;6557.967210163966;6563.638999855006;7004.929950700504;7319.085114360705;7322.890156647654;7331.193568707438;7333.486655934087;7204.56772593646;7219.963900180518;7241.855162896739;7283.927160728378;7287.927120728805;7041.190263119755;7084.822879428004;7112.466565007645;7135.928640713631;7151.106111736033;28171.85914070437;29466;29489.410211795857;29598.852005739835;29683.257918551993;2139.7432308123125;2144.9811339613716;2154.7522034966023;2164.3615133535645;2189.7262842144733;19343.80656193434;19698.80301196984;20060.29788957394;20064.498387540283;20097.799022009738;2527.128140791424;2574.1633968959977;2588.715241323453;2610.4387556675406;2610.69976952651;127238;129346;132545;138728.61271387257;140520.2973985134;19414.611707765765;20183.275257840003;21055.368338949855;22064;22322.55354892893;40370.59629403727;40637;40718.796406017784;40754.18491630151;41134.177316453504;11410.258333208314;11425.143114266462;11436.142289328334;11458.166693329027;11588;9392.154706076486;9413.341066125442;9533.761655958657;9616.471094089753;9672.661456848977;10428.530716117793;10474.528646210938;11015.83476247857;11145.66252049743;11148.386838723785;3687.317846198408;3719.6466335698065;4160.649233183302;4183.267928112568;4379.737215767001;954.0030667952007;976.6142373762466;985.6599473181741;991.7718924647371;992.8609994600762;18598.16308266104;18611.627767444847;18784.342548010754;18947.43157705271;19189.904050479938;1026.1175389165312;1038.8493668418037;1047.3611097230682;1048.4495639789172;1052.7315534538643;10337.22470814692;10514;10589.470526473646;10599.788004240027;10964.835527467094;485571;491112;506928;510564;512755;107350.46324768326;108282;115072.42463787795;116549.4172529149;119162;1141.5148561861176;1162.0529268646196;1183.9112066594867;1186.821976703484;1190.0301254477572;16884.155792210095;17012.74480882763;17019.23413446373;17159.57101072483;17238.827611723722;54673.179902300704;55417.722911385186;56273.15590266068;56963.715181423824;57063;69660.30339696538;70245.29754702593;70556.29443705497;71973;72239;19168.849869007903;19186.232550697816;19255.51861203481;19435.222591096197;19505.70741438851;22304.330870073925;22449;22518.211862584732;22561.210357637403;22685.75228362456;16214.108224047319;16228.350865965229;17367.739483908004;17460.91269543644;17999.19003644813;16019.839801601835;16050.277737501607;16079.839201607834;16300.021998680117;16325.918370408071;16369.590760231089;16717.414890478776;18086.81913180904;18458;18496.81503184951;17880;19045.14296856617;19100.90449547799;19113.80886191176;19117.61764764669;16917.74623380675;17162;17173.742393863853;17336.306547738455;17504.649907002044 04:12:02 INFO - PID 11593 | |3;mootools.html;1320.782070958292;1374.505178135871;1374.6357215337944;1375.717977814548;1386.2722070912773;15128.319225634845;15812.734981201505;15905.602359940993;15939.203039848018;15967.760483592741;15584.142872142027;15740.134292613902;15785.21073946301;15798.131102789343;15800.84199158008;2735.8221715588425;2755.917322480329;2811.9718802811913;2812.929676758087;2814.5074611942932;2732.79504037197;2760.1167626359475;2764.4471105778825;2770.0858716623466;2791.4556661451024;2593.455374371384;2719.809613327068;2770.9584356234673;2771.8198317109423;2772.792040596953;2743.4513097380604;2751.7798576113864;2790.441911617664;2812.086072026589;2815.845128517931;2358.4457652451833;2437.5612389769835;2689.8789554470095;2724.768394686454;2731;12586.37068146589;12727.299998500079;14743;15301.08193508393;15309;8015.47899386538;8297.626606802649;8306.127856575093;8334.62494187757;8338.166183381674;5164.1995490699;5279.894402111975;5468.535174510172;5472.288602481652;5475.863103422446;1918.194358369488;1953.1894263880472;1956.461972957448;1991.2433275355418;1992.3524854422371;26813.597796033075;27591.034313798922;27606;27624.171274861586;27658.723412765816;7128.683177967077;7144.714211431485;7193.820154496179;7395.297446742551;7468.850622987618;20520.794792052187;20572.38282851517;20616.278430254868;20665.690014649794;20731.58536829285;8053.1946805319;8228.259456648811;8252.298554622925;8269.710560130367;8295.8340833183;7113.608751518716;7373.963130184422;7390.22402647725;7438.516496427715;7529.962350188323;5571.554275657938;5758.1650660654805;5764.884702305931;5806.564507661942;5821.76712931478;1741.2077504735314;1770.4954088085092;1794.5244510204807;1805.9638807223782;1816.8364847163818;888.3559419420868;902.1745103230471;918.0589895357313;930.3208657679796;932.3380399916135;7633.580153091633;7813.10149332834;8617.95691021541;8789.077146899612;8814.77963050916;719.7624783821326;739.6893304811991;745.3701622129292;748.6256871564218;752.9058867641545;5292.655977361459;5453.945460545344;5456.972715136399;5536.695481748462;5606.24315717373;21228.363149105553;21391.46521336948;21803.67294490584;21950.780492195194;22403.55192896133;21865.781342186692;21887.671684924422;21903;22149.66775498369;22555.774442255366;11377.601783937522;11446.14153938458;11666.358350290815;11700.35648039349;11874.643760687193;8433.536155511505;8485.066642669424;8489.957550212457;8563.95718021406;8598.61306241233;17880.374186903395;18294.542636434195;19219;19234.80765192386;19418.90290548538;19144.425667230007;19177.424677259703;19512.414627561197;19710.90144549268;19803.504912377306;12506.499740010298;12613.243205407705;12653.87346126527;12705.872941270838;12727.87272127304;13881.930590346983;13938.442462301395;14044.929775351058;14063.578092657237;14152.92923535417;10763.300385474919;11422.428878555873;11443.542258309908;11443.771124577295;11592.246503977214;10536.209784266057;10766.623168189075;10835.566577336818;11031.22781405294;11039.06167975699;9704.75738106553;9717.465539395402;9811.920688724378;9865.26010549226;9873.901260987299;7078.362947334765;7245.203027666847;7249.601271930094;7280.271972802678;7293.854122917406;7623;7665.8466830661955;7702.691892324245;7736.7292144774665;7745.341645960157 04:12:02 INFO - PID 11593 | |4;prototype.html;509.5312312672343;510.76249543962064;538;538.359352370679;549.8240563019833;6240.43836054755;6277.489004398243;6279.780207692732;6292.528060395472;6356.427921487065;6203.286622038456;6224.315325314223;6266.8406344826235;6278.403551662596;6311.463525600329;5176.3176967485715;5195.168772996321;5247.553957913582;5267.55225805807;5293.338332708411;5230.555402790767;5255.894882102356;5257.1851363038595;5316.813911513098;5342.839714808562;5113.514216149479;5149.81975630853;5244.108501554745;5289.814856480024;5296.973515132419;5178.171492561191;5221.947780522184;5267.815626453094;5279.894402111936;5284.5243928046275;4875.195592727196;4879.829205977774;4883.755812209411;4917.286993385975;4933.284673722326;5968.313643930916;6184.8763024739255;6239.65681887496;6255.40573645503;6258.092576576417;5976.820695379146;6051.394860513958;6053.969730151365;6084;6119;6616.503762217805;6617;6632.80101596948;6660.400563949268;6671.93328066718;5038.193888977783;5320.866978325535;5326.617597825409;5344.278522399465;5358.46415358461;6841.452683785285;6871.278515755874;6952.323355508115;7003.544769590011;7018.859622807515;5450.700211488406;5473.9452605474235;5484.067708489566;5538.864532770773;5555.194496798023;5596.552275817925;5642;5653.943460565341;5657.377688454267;5672.355017045011;5959.970200148971;6012.909806352908;6054.8183554493435;6105.267367915879;6135.202423684982;6653.234877988996;6727.562708423937;6767.39093481589;6781.796546103625;6790.253072162058;1961.3429501117;1963.8232559069752;1976.2885361269932;1979.7921218272163;2000.549876277855;1384.4254634326844;1423.843377228504;1426.7788492783427;1471.919044452544;1482.6738117614107;5526.613137080366;5611.663300201919;5621.381648018714;5709.65742055478;5720.170575266563;6679;6689.264180940093;6699.363560461748;6705.228898676617;6749.257581666013;5591.944080559224;5607.82235730493;5710.229119068956;5725.828225153252;5789.334226563915;3516.7538272320694;3528.2767032758225;3541.5218945442552;3553.857845686195;3582.3193593217725;6480.222373315232;6506.794564348502;6557.606543607303;6558.868822623521;6560.278369379364;6883.827904302432;6908.481863860231;6928.965355173192;6939.340762627542;6955.756548520778;6326;6379.393957574116;6409.327020662857;6428.325025872309;6449.677516124175;6510.902336465051;6587.945928651393;6617.338266173344;6623.416867421805;6632.966835165793;6459.935400645933;6509.544331896722;6558.409743123142;6620.834479137868;6638.50211234169;6315.410681620514;6329.303776584664;6355.569996750879;6451.870882608634;6480.449161821298;5442.346918369821;5476.424975377528;5488.4785945335125;5515.365732940763;5548.195511650707;6315.315990704024;6512.47900167976;6650.467962562887;6707.765228217184;6786.626735529593;6414.647194404352;6444.097826304415;6447.742090316522;6470.773522926675;6507.772227971998;6449.355064493513;6450.000249961264;6450.322716114928;6509.707063182263;6581.243157037002;6285.277193122849;6301.4328710416285;6360.681965901594;6365.684653314534;6385.892655423606;6470.320616335405;6558.311377305315;6573.107832553661;6604.3725846044545;6615.4376877965915;6288.591241569284;6309.400606942333;6349.904751428825;6389.744410223539;6395.712192951235 04:12:02 INFO - PID 11593 | |5;yui.html;887.8535041718114;894.3515950935573;909.9454032758035;911.2482202183196;913.4519288426941;16564.254608542615;16671.41650042249;16770.329186832543;16881.40915067973;16955.491335259932;18386.632267354646;18636.906815465903;18638.906805465955;18662.626747465078;18672.25310987559;952.2572393533021;974.3569244298765;976.9218462522981;977.4184360305607;978.0512902484578;982.5971351745785;982.8378317577591;983.2969426859794;983.306768728045;984.3650845204838;990.1237404896647;1007.9848802267935;1009.6314845081566;1028.609128531157;1037.1547189040946;985.2265971212564;990.1484723138095;993.7813680990171;1003.0070230471816;1003.1573478278245;733.1312394812164;737.7823542055053;741.6884908338511;743.5464366736287;744.9813754656122;19654;20238.898805506025;20342.898285508625;20385.18459261628;20386.69419958702;21896.45258868541;22069.889650551646;22520.54958900813;22707.545849082926;22711.545769084525;16379.262933168036;16627.41804036865;16657.33370665184;16792.832071679248;16918.915405423017;3775.716821238391;3781.4894989176382;3792.7534710243744;3807.200487897545;3811.656950874407;100561;134190;135754.32122839324;138825;140087.29956350152;15874.126923019345;16353.672926541403;16366.672666546603;16381.262843172086;16437.83562164387;31192.532112018336;31733.682663173535;32003.51994720081;32094.518582221284;32168;8709.520976346363;8752.8687069694;8819.29445644347;8842.734717958472;8846.557672116369;3762.285165818486;3988.7008474363956;3989.401589761501;4015.738976966488;4016.3774614934146;5477;5573.749181286771;5588.86027849307;5605.159226116034;5607.719614019283;1019.8623185869961;1053.8840727519967;1056.27645063132;1061.554147258138;1070.844727514506;609.768288050538;635.8505751148476;641.9325970773095;654.8821212181758;657.6974591687878;11447.771044579229;11531.769364612828;12013.339266340436;12709;13170.60488185356;672.3008071605476;678.7815870512442;690.0270618427993;691.381213813634;700.870338987289;5436.510714035756;5468.863278417992;5571.164325351229;5573.303337082864;5587.972060139755;118620.40689796496;120123;122281.38859305647;123662.38168809099;126642;108389;108457;109146.90853091526;111781;113006;90369;93798.0620193803;94268.52865735764;94525.58211626831;94937.52531237299;10348.637797677045;10371.533281002223;10380.221483388927;10441.738956526147;10653.57385704563;43833;44711;45975.77012114918;46163.76918115388;46783.76608116938;57891;59112.40887591241;59300.40699592949;59394;60097.098543522756;15912.681746365239;15930.283137259083;15985.360585576447;16113.113778742281;16129.193540323171;15782.36870525212;16042.598935026252;16048.518544443685;16095.919520402324;16136.273867676218;14837.183954882585;14873.405063797327;14904.925475372555;15048.322825473098;15168.696626067638;15168.924155379153;15467.303971321542;15556;15574;15693.372265109725;15160.393584256506;15252.084874907541;15396;15422.228888555752;15490.690186196438;11492.712682182679;11606.825897611712;11635.360055197045;11990.160688751703;12029.218100823418;11636.196389559631;11644.941775291069;11893.702657433634;11922.284662920252;12096.818547721967 04:12:02 INFO - PID 11593 | __end_tp_report 04:12:02 INFO - PID 11593 | __start_cc_report 04:12:02 INFO - PID 11593 | _x_x_mozilla_cycle_collect,306 04:12:02 INFO - PID 11593 | __end_cc_report 04:12:02 INFO - PID 11593 | __startTimestamp1506424322227__endTimestamp 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | ------- Summary: start ------- 04:12:02 INFO - PID 11593 | Number of tests: 6 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#0] dojo.html Cycles:165 Average:6139.45 Median:6410.13 stddev:853.60 (13.3%) stddev-sans-first:822.06 04:12:02 INFO - PID 11593 | Values: 3092.0 3104.4 3135.3 3184.2 3186.1 6083.2 6176.4 6240.7 6314.8 6365.5 6170.1 6220.1 6240.3 6240.7 6271.8 5718.1 5728.4 5769.7 5809.4 5811.2 5784.9 5844.8 5871.4 5892.9 5905.4 850.1 5633.5 5659.2 5674.6 5891.5 5709.9 5751.8 5831.8 5846.9 5856.0 5722.3 5738.9 5805.1 5809.9 5810.2 6234.6 6249.7 6304.9 6345.8 6359.8 6707.7 6712.7 6806.3 6808.7 6823.8 6744.4 6783.7 6827.5 6828.5 6856.0 6060.6 6102.6 6175.3 6188.3 6214.4 6955.7 6960.4 6994.5 7000.2 7031.4 6583.2 6590.4 6607.1 6656.5 6688.6 6441.6 6593.8 6695.2 6769.3 6773.3 6601.1 6678.9 6681.9 6722.7 6729.5 6689.0 6763.5 6771.3 6781.8 6805.6 5142.5 5185.0 5207.7 5264.8 5282.2 4545.7 4555.9 4566.1 4581.7 4602.9 5745.1 5776.9 5797.5 5825.6 5827.1 6542.4 6732.4 6747.2 6803.7 6823.3 5683.3 5725.6 5791.0 5820.4 5828.0 5821.0 5837.7 5841.9 5847.3 5862.7 6442.8 6589.8 6603.7 6622.6 6629.2 6758.4 6767.5 6843.8 6863.5 6868.2 6316.0 6336.1 6419.6 6452.5 6539.3 6484.2 6545.9 6581.6 6594.4 6595.5 6684.8 6691.1 6702.7 6708.3 6724.0 6520.6 6532.6 6534.4 6598.4 6602.7 6450.5 6484.8 6498.4 6559.0 6569.9 6212.9 6347.9 6400.5 6530.2 6541.6 6435.6 6453.2 6455.8 6537.2 6577.5 6169.7 6337.2 6367.3 6410.1 6445.8 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#1] ext.html Cycles:180 Average:37518.50 Median:34818.80 stddev:53676.09 (154.2%) stddev-sans-first:53756.07 04:12:02 INFO - PID 11593 | Values: 855.5 857.6 887.4 912.1 914.3 39828.8 41455.6 41487.6 41512.2 41533.8 37819.8 37964.2 38230.4 38297.0 38302.6 7303.7 7401.2 7410.2 7421.0 7430.6 7260.9 7280.7 7284.0 7286.2 7358.1 7329.0 7902.6 8065.1 8079.2 8124.1 7987.5 7995.1 8021.2 8046.5 8057.3 7942.2 7987.5 7995.9 8015.9 8043.0 38002.2 38046.0 38226.0 38492.2 38492.6 3503.3 3534.5 3559.3 3568.3 3570.4 31409.5 31443.5 31496.7 31520.0 31547.0 5172.7 5188.1 5202.8 5214.7 5235.6 190729.0 192356.0 193562.0 193911.0 194546.0 48536.3 48863.8 48886.5 48991.8 49047.5 52274.5 52792.5 53431.2 53499.7 53584.0 16225.4 16371.5 16426.0 16466.7 16488.2 13412.5 13573.1 13617.5 13618.5 13660.3 14775.4 14784.9 14795.8 14832.0 14903.1 5779.6 5875.1 5892.9 5922.8 5926.2 992.3 1000.3 1002.5 1005.2 1019.1 23171.5 23265.1 23456.2 23621.0 23775.4 1096.9 1118.0 1128.4 1128.7 1135.4 12487.4 12577.9 12656.6 12704.7 12836.7 228350.0 230221.0 230663.0 231930.0 232543.0 44538.6 45303.5 45508.3 52416.5 53093.7 1442.8 1449.1 1452.3 1459.2 1459.7 26658.5 26789.0 27117.9 27213.6 27814.2 36900.8 37484.8 37526.0 37752.1 37757.1 195781.0 196058.0 196120.0 197247.0 197322.0 33950.8 34526.7 34591.1 34666.3 34691.5 42342.8 42858.4 43274.4 43417.8 43493.3 30953.8 31001.8 31502.8 31660.2 31679.4 30690.1 30879.7 31072.4 31146.0 31400.0 33991.3 34679.0 34946.1 35324.1 35455.6 29668.4 30233.8 30543.0 30864.7 30876.1 22311.6 22662.9 22847.7 22928.3 22974.3 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#2] jquery.html Cycles:180 Average:35752.22 Median:22313.44 stddev:84003.44 (376.5%) stddev-sans-first:84197.54 04:12:02 INFO - PID 11593 | Values: 561.4 582.9 590.1 599.9 618.5 21759.7 22376.6 22624.4 22708.0 22725.8 22872.9 24117.5 24347.9 24602.6 24612.4 6440.7 6565.5 6619.7 6621.6 6631.0 6440.7 6504.5 6539.8 6558.0 6563.6 7004.9 7319.1 7322.9 7331.2 7333.5 7204.6 7220.0 7241.9 7283.9 7287.9 7041.2 7084.8 7112.5 7135.9 7151.1 28171.9 29466.0 29489.4 29598.9 29683.3 2139.7 2145.0 2154.8 2164.4 2189.7 19343.8 19698.8 20060.3 20064.5 20097.8 2527.1 2574.2 2588.7 2610.4 2610.7 127238.0 129346.0 132545.0 138728.6 140520.3 19414.6 20183.3 21055.4 22064.0 22322.6 40370.6 40637.0 40718.8 40754.2 41134.2 11410.3 11425.1 11436.1 11458.2 11588.0 9392.2 9413.3 9533.8 9616.5 9672.7 10428.5 10474.5 11015.8 11145.7 11148.4 3687.3 3719.6 4160.6 4183.3 4379.7 954.0 976.6 985.7 991.8 992.9 18598.2 18611.6 18784.3 18947.4 19189.9 1026.1 1038.8 1047.4 1048.4 1052.7 10337.2 10514.0 10589.5 10599.8 10964.8 485571.0 491112.0 506928.0 510564.0 512755.0 107350.5 108282.0 115072.4 116549.4 119162.0 1141.5 1162.1 1183.9 1186.8 1190.0 16884.2 17012.7 17019.2 17159.6 17238.8 54673.2 55417.7 56273.2 56963.7 57063.0 69660.3 70245.3 70556.3 71973.0 72239.0 19168.8 19186.2 19255.5 19435.2 19505.7 22304.3 22449.0 22518.2 22561.2 22685.8 16214.1 16228.4 17367.7 17460.9 17999.2 16019.8 16050.3 16079.8 16300.0 16325.9 16369.6 16717.4 18086.8 18458.0 18496.8 17880.0 19045.1 19100.9 19113.8 19117.6 16917.7 17162.0 17173.7 17336.3 17504.6 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#3] mootools.html Cycles:180 Average:9609.50 Median:2747.62 stddev:6922.42 (251.9%) stddev-sans-first:6913.83 04:12:02 INFO - PID 11593 | Values: 1320.8 1374.5 1374.6 1375.7 1386.3 15128.3 15812.7 15905.6 15939.2 15967.8 15584.1 15740.1 15785.2 15798.1 15800.8 2735.8 2755.9 2812.0 2812.9 2814.5 2732.8 2760.1 2764.4 2770.1 2791.5 2593.5 2719.8 2771.0 2771.8 2772.8 2743.5 2751.8 2790.4 2812.1 2815.8 2358.4 2437.6 2689.9 2724.8 2731.0 12586.4 12727.3 14743.0 15301.1 15309.0 8015.5 8297.6 8306.1 8334.6 8338.2 5164.2 5279.9 5468.5 5472.3 5475.9 1918.2 1953.2 1956.5 1991.2 1992.4 26813.6 27591.0 27606.0 27624.2 27658.7 7128.7 7144.7 7193.8 7395.3 7468.9 20520.8 20572.4 20616.3 20665.7 20731.6 8053.2 8228.3 8252.3 8269.7 8295.8 7113.6 7374.0 7390.2 7438.5 7530.0 5571.6 5758.2 5764.9 5806.6 5821.8 1741.2 1770.5 1794.5 1806.0 1816.8 888.4 902.2 918.1 930.3 932.3 7633.6 7813.1 8618.0 8789.1 8814.8 719.8 739.7 745.4 748.6 752.9 5292.7 5453.9 5457.0 5536.7 5606.2 21228.4 21391.5 21803.7 21950.8 22403.6 21865.8 21887.7 21903.0 22149.7 22555.8 11377.6 11446.1 11666.4 11700.4 11874.6 8433.5 8485.1 8490.0 8564.0 8598.6 17880.4 18294.5 19219.0 19234.8 19418.9 19144.4 19177.4 19512.4 19710.9 19803.5 12506.5 12613.2 12653.9 12705.9 12727.9 13881.9 13938.4 14044.9 14063.6 14152.9 10763.3 11422.4 11443.5 11443.8 11592.2 10536.2 10766.6 10835.6 11031.2 11039.1 9704.8 9717.5 9811.9 9865.3 9873.9 7078.4 7245.2 7249.6 7280.3 7293.9 7623.0 7665.8 7702.7 7736.7 7745.3 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#4] prototype.html Cycles:180 Average:5629.31 Median:6247.92 stddev:1485.54 (23.8%) stddev-sans-first:1439.15 04:12:02 INFO - PID 11593 | Values: 509.5 510.8 538.0 538.4 549.8 6240.4 6277.5 6279.8 6292.5 6356.4 6203.3 6224.3 6266.8 6278.4 6311.5 5176.3 5195.2 5247.6 5267.6 5293.3 5230.6 5255.9 5257.2 5316.8 5342.8 5113.5 5149.8 5244.1 5289.8 5297.0 5178.2 5221.9 5267.8 5279.9 5284.5 4875.2 4879.8 4883.8 4917.3 4933.3 5968.3 6184.9 6239.7 6255.4 6258.1 5976.8 6051.4 6054.0 6084.0 6119.0 6616.5 6617.0 6632.8 6660.4 6671.9 5038.2 5320.9 5326.6 5344.3 5358.5 6841.5 6871.3 6952.3 7003.5 7018.9 5450.7 5473.9 5484.1 5538.9 5555.2 5596.6 5642.0 5653.9 5657.4 5672.4 5960.0 6012.9 6054.8 6105.3 6135.2 6653.2 6727.6 6767.4 6781.8 6790.3 1961.3 1963.8 1976.3 1979.8 2000.5 1384.4 1423.8 1426.8 1471.9 1482.7 5526.6 5611.7 5621.4 5709.7 5720.2 6679.0 6689.3 6699.4 6705.2 6749.3 5591.9 5607.8 5710.2 5725.8 5789.3 3516.8 3528.3 3541.5 3553.9 3582.3 6480.2 6506.8 6557.6 6558.9 6560.3 6883.8 6908.5 6929.0 6939.3 6955.8 6326.0 6379.4 6409.3 6428.3 6449.7 6510.9 6587.9 6617.3 6623.4 6633.0 6459.9 6509.5 6558.4 6620.8 6638.5 6315.4 6329.3 6355.6 6451.9 6480.4 5442.3 5476.4 5488.5 5515.4 5548.2 6315.3 6512.5 6650.5 6707.8 6786.6 6414.6 6444.1 6447.7 6470.8 6507.8 6449.4 6450.0 6450.3 6509.7 6581.2 6285.3 6301.4 6360.7 6365.7 6385.9 6470.3 6558.3 6573.1 6604.4 6615.4 6288.6 6309.4 6349.9 6389.7 6395.7 04:12:02 INFO - PID 11593 | 04:12:02 INFO - PID 11593 | [#5] yui.html Cycles:180 Average:23970.94 Median:19163.13 stddev:34595.52 (180.5%) stddev-sans-first:34649.15 04:12:02 INFO - PID 11593 | Values: 887.9 894.4 909.9 911.2 913.5 16564.3 16671.4 16770.3 16881.4 16955.5 18386.6 18636.9 18638.9 18662.6 18672.3 952.3 974.4 976.9 977.4 978.1 982.6 982.8 983.3 983.3 984.4 990.1 1008.0 1009.6 1028.6 1037.2 985.2 990.1 993.8 1003.0 1003.2 733.1 737.8 741.7 743.5 745.0 19654.0 20238.9 20342.9 20385.2 20386.7 21896.5 22069.9 22520.5 22707.5 22711.5 16379.3 16627.4 16657.3 16792.8 16918.9 3775.7 3781.5 3792.8 3807.2 3811.7 100561.0 134190.0 135754.3 138825.0 140087.3 15874.1 16353.7 16366.7 16381.3 16437.8 31192.5 31733.7 32003.5 32094.5 32168.0 8709.5 8752.9 8819.3 8842.7 8846.6 3762.3 3988.7 3989.4 4015.7 4016.4 5477.0 5573.7 5588.9 5605.2 5607.7 1019.9 1053.9 1056.3 1061.6 1070.8 609.8 635.9 641.9 654.9 657.7 11447.8 11531.8 12013.3 12709.0 13170.6 672.3 678.8 690.0 691.4 700.9 5436.5 5468.9 5571.2 5573.3 5588.0 118620.4 120123.0 122281.4 123662.4 126642.0 108389.0 108457.0 109146.9 111781.0 113006.0 90369.0 93798.1 94268.5 94525.6 94937.5 10348.6 10371.5 10380.2 10441.7 10653.6 43833.0 44711.0 45975.8 46163.8 46783.8 57891.0 59112.4 59300.4 59394.0 60097.1 15912.7 15930.3 15985.4 16113.1 16129.2 15782.4 16042.6 16048.5 16095.9 16136.3 14837.2 14873.4 14904.9 15048.3 15168.7 15168.9 15467.3 15556.0 15574.0 15693.4 15160.4 15252.1 15396.0 15422.2 15490.7 11492.7 11606.8 11635.4 11990.2 12029.2 11636.2 11644.9 11893.7 11922.3 12096.8 04:12:02 INFO - PID 11593 | -------- Summary: end -------- 04:12:02 INFO - PID 11593 | 04:12:03 INFO - TEST-INFO | 11593: exit 0 04:12:03 INFO - TEST-OK | dromaeo_css | took 1113539ms 04:12:03 INFO - TEST-START | kraken 04:12:03 INFO - Initialising browser for kraken test... 04:12:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36618/getInfo.html -profile /tmp/tmpDgyq3X/profile 04:12:03 INFO - TEST-INFO | started process 11980 (/builds/slave/test/build/application/firefox/firefox http://localhost:36618/getInfo.html) 04:12:09 INFO - TEST-INFO | 11980: exit 0 04:12:09 INFO - Browser initialized. 04:12:09 INFO - Running cycle 1/1 for kraken test... 04:12:09 INFO - Using env: {'DISPLAY': ':0', 04:12:09 INFO - 'HOME': '/home/cltbld', 04:12:09 INFO - 'JSGC_DISABLE_POISONING': '1', 04:12:09 INFO - 'LANG': 'en_US.UTF-8', 04:12:09 INFO - 'LANGUAGE': 'en_US:en', 04:12:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:12:09 INFO - 'LOGNAME': 'cltbld', 04:12:09 INFO - 'MAIL': '/var/mail/cltbld', 04:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:09 INFO - 'MOZ_ACCELERATED': '1', 04:12:09 INFO - 'MOZ_CRASHREPORTER': '1', 04:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:12:09 INFO - 'MOZ_NO_REMOTE': '1', 04:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:09 INFO - 'MOZ_WEBRENDER': '1', 04:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:09 INFO - 'NO_EM_RESTART': '1', 04:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:09 INFO - 'PWD': '/builds/slave/test', 04:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:09 INFO - 'RUST_BACKTRACE': 'full', 04:12:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:12:09 INFO - 'SHELL': '/bin/bash', 04:12:09 INFO - 'SHLVL': '1', 04:12:09 INFO - 'TERM': 'linux', 04:12:09 INFO - 'TMOUT': '86400', 04:12:09 INFO - 'USER': 'cltbld', 04:12:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1506410374.200797-1290141514', 04:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:09 INFO - '_': '/tools/buildbot/bin/python'} 04:12:09 INFO - TEST-INFO | started process 12224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgyq3X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:10 INFO - PID 12224 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:12:10 INFO - PID 12224 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:12:10 INFO - PID 12224 | 04:12:10 INFO - PID 12224 | (/builds/slave/test/build/application/firefox/firefox:12284): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:12:10 INFO - PID 12224 | 04:12:21 INFO - PID 12224 | RSS: Main: 194433024 04:12:21 INFO - PID 12224 | 04:12:23 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36618/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:24 INFO - PID 12224 | RSS: Main: 197206016 04:12:24 INFO - PID 12224 | 04:12:27 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36618/tests/kraken/driver.html?testName=audio-dft) 04:12:27 INFO - PID 12224 | RSS: Main: 196452352 04:12:27 INFO - PID 12224 | 04:12:31 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36618/tests/kraken/driver.html?testName=audio-fft) 04:12:31 INFO - PID 12224 | RSS: Main: 194326528 04:12:31 INFO - PID 12224 | 04:12:33 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36618/tests/kraken/driver.html?testName=audio-oscillator) 04:12:34 INFO - PID 12224 | RSS: Main: 194215936 04:12:34 INFO - PID 12224 | 04:12:36 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:37 INFO - PID 12224 | RSS: Main: 193654784 04:12:37 INFO - PID 12224 | 04:12:40 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36618/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:41 INFO - PID 12224 | RSS: Main: 196997120 04:12:41 INFO - PID 12224 | 04:12:44 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36618/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:45 INFO - PID 12224 | RSS: Main: 197115904 04:12:45 INFO - PID 12224 | 04:12:48 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36618/tests/kraken/driver.html?testName=json-parse-financial) 04:12:49 INFO - PID 12224 | RSS: Main: 197238784 04:12:49 INFO - PID 12224 | 04:12:50 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:51 INFO - PID 12224 | RSS: Main: 197738496 04:12:51 INFO - PID 12224 | 04:12:53 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:53 INFO - PID 12224 | RSS: Main: 193753088 04:12:53 INFO - PID 12224 | 04:12:55 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:56 INFO - PID 12224 | RSS: Main: 194310144 04:12:56 INFO - PID 12224 | 04:12:59 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:59 INFO - PID 12224 | RSS: Main: 194957312 04:12:59 INFO - PID 12224 | 04:13:02 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:03 INFO - PID 12224 | RSS: Main: 195158016 04:13:03 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | Cycle 1(1): loaded http://localhost:36618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36618/tests/kraken/driver.html?testName=ai-astar) 04:13:05 INFO - PID 12224 | RSS: Main: 195784704 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | __start_tp_report 04:13:05 INFO - PID 12224 | _x_x_mozilla_page_load 04:13:05 INFO - PID 12224 | _x_x_mozilla_page_load_details 04:13:05 INFO - PID 12224 | |i|pagename|runs| 04:13:05 INFO - PID 12224 | |0;ai-astar;111;110;109;101;112;109;107;114;107;110 04:13:05 INFO - PID 12224 | |1;audio-beat-detection;124;116;117;116;118;120;116;122;117;123 04:13:05 INFO - PID 12224 | |2;audio-dft;162;162;170;169;172;168;174;175;172;166 04:13:05 INFO - PID 12224 | |3;audio-fft;75;74;75;77;76;82;77;79;78;84 04:13:05 INFO - PID 12224 | |4;audio-oscillator;81;88;86;84;85;79;89;79;89;79 04:13:05 INFO - PID 12224 | |5;imaging-gaussian-blur;115;120;114;114;114;115;111;115;118;112 04:13:05 INFO - PID 12224 | |6;imaging-darkroom;154;152;152;155;149;150;150;150;150;153 04:13:05 INFO - PID 12224 | |7;imaging-desaturate;105;97;94;95;95;101;97;97;102;96 04:13:05 INFO - PID 12224 | |8;json-parse-financial;57;64;55;54;57;53;53;52;53;53 04:13:05 INFO - PID 12224 | |9;json-stringify-tinderbox;51;39;39;39;45;51;47;48;38;46 04:13:05 INFO - PID 12224 | |10;stanford-crypto-aes;73;72;79;79;73;74;74;78;78;78 04:13:05 INFO - PID 12224 | |11;stanford-crypto-ccm;117;118;121;110;116;116;112;110;117;118 04:13:05 INFO - PID 12224 | |12;stanford-crypto-pbkdf2;169;165;175;169;170;166;181;172;166;176 04:13:05 INFO - PID 12224 | |13;stanford-crypto-sha256-iterative;70;66;68;61;69;67;67;66;67;64 04:13:05 INFO - PID 12224 | __end_tp_report 04:13:05 INFO - PID 12224 | __start_cc_report 04:13:05 INFO - PID 12224 | _x_x_mozilla_cycle_collect,739 04:13:05 INFO - PID 12224 | __end_cc_report 04:13:05 INFO - PID 12224 | __startTimestamp1506424385313__endTimestamp 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | ------- Summary: start ------- 04:13:05 INFO - PID 12224 | Number of tests: 14 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:3.67 04:13:05 INFO - PID 12224 | Values: 111.0 110.0 109.0 101.0 112.0 109.0 107.0 114.0 107.0 110.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:119.00 stddev:3.11 (2.6%) stddev-sans-first:2.69 04:13:05 INFO - PID 12224 | Values: 124.0 116.0 117.0 116.0 118.0 120.0 116.0 122.0 117.0 123.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#2] audio-dft Cycles:10 Average:169.00 Median:171.00 stddev:4.57 (2.7%) stddev-sans-first:4.09 04:13:05 INFO - PID 12224 | Values: 162.0 162.0 170.0 169.0 172.0 168.0 174.0 175.0 172.0 166.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#3] audio-fft Cycles:10 Average:77.70 Median:77.50 stddev:3.20 (4.1%) stddev-sans-first:3.24 04:13:05 INFO - PID 12224 | Values: 75.0 74.0 75.0 77.0 76.0 82.0 77.0 79.0 78.0 84.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:85.50 stddev:4.15 (4.9%) stddev-sans-first:4.27 04:13:05 INFO - PID 12224 | Values: 81.0 88.0 86.0 84.0 85.0 79.0 89.0 79.0 89.0 79.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:2.62 (2.3%) stddev-sans-first:2.77 04:13:05 INFO - PID 12224 | Values: 115.0 120.0 114.0 114.0 114.0 115.0 111.0 115.0 118.0 112.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.00 stddev:2.01 (1.3%) stddev-sans-first:1.92 04:13:05 INFO - PID 12224 | Values: 154.0 152.0 152.0 155.0 149.0 150.0 150.0 150.0 150.0 153.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:95.50 stddev:3.57 (3.7%) stddev-sans-first:2.71 04:13:05 INFO - PID 12224 | Values: 105.0 97.0 94.0 95.0 95.0 101.0 97.0 97.0 102.0 96.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.57 (6.6%) stddev-sans-first:3.72 04:13:05 INFO - PID 12224 | Values: 57.0 64.0 55.0 54.0 57.0 53.0 53.0 52.0 53.0 53.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#9] json-stringify-tinderbox Cycles:10 Average:44.30 Median:46.50 stddev:5.14 (11.1%) stddev-sans-first:4.85 04:13:05 INFO - PID 12224 | Values: 51.0 39.0 39.0 39.0 45.0 51.0 47.0 48.0 38.0 46.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:78.00 stddev:2.82 (3.6%) stddev-sans-first:2.80 04:13:05 INFO - PID 12224 | Values: 73.0 72.0 79.0 79.0 73.0 74.0 74.0 78.0 78.0 78.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:117.00 stddev:3.66 (3.1%) stddev-sans-first:3.84 04:13:05 INFO - PID 12224 | Values: 117.0 118.0 121.0 110.0 116.0 116.0 112.0 110.0 117.0 118.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.00 stddev:5.13 (3.0%) stddev-sans-first:5.40 04:13:05 INFO - PID 12224 | Values: 169.0 165.0 175.0 169.0 170.0 166.0 181.0 172.0 166.0 176.0 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.55 (3.8%) stddev-sans-first:2.37 04:13:05 INFO - PID 12224 | Values: 70.0 66.0 68.0 61.0 69.0 67.0 67.0 66.0 67.0 64.0 04:13:05 INFO - PID 12224 | -------- Summary: end -------- 04:13:05 INFO - PID 12224 | 04:13:05 INFO - PID 12224 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:13:06 INFO - TEST-INFO | 12224: exit 0 04:13:06 INFO - TEST-OK | kraken | took 63112ms 04:13:06 INFO - SUITE-END | took 1176s 04:13:06 INFO - Completed test suite (00:19:36) 04:13:06 INFO - javascript benchmark 04:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8640.630090134553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.969080309199, 3104.3636054608805, 3135.2788858562535, 3184.2357834119816, 3186.1238159506133, 6083.178770865932, 6176.351483094272, 6240.687965601719, 6314.7789827356055, 6365.52258580606, 6170.074488826678, 6220.129181914524, 6240.282367527736, 6240.6879656017245, 6271.780487682932, 5718.113692377678, 5728.369879313273, 5769.653820770767, 5809.448102430283, 5811.186433899257, 5784.855378615526, 5844.824655260349, 5871.412858714137, 5892.911606325887, 5905.438983296602, 850.0818981340886, 5633.549316054727, 5659.151127330892, 5674.631148975303, 5891.499222566087, 5709.914351284734, 5751.820876720262, 5831.825045248649, 5846.883062338772, 5855.970720146414, 5722.256106706143, 5738.913916291259, 5805.10020946754, 5809.883802323972, 5810.1865738796605, 6234.594751341148, 6249.656268905208, 6304.905426418607, 6345.809625711236, 6359.8092057238355, 6707.731690732365, 6712.697928593225, 6806.285340039274, 6808.6936087876165, 6823.761168359084, 6744.426723728489, 6783.72865085396, 6827.48793840459, 6828.453723702092, 6856.040154378391, 6060.636361818261, 6102.603330783485, 6175.2898416681755, 6188.257409110845, 6214.40963108504, 6955.721771129098, 6960.37356637905, 6994.510384273052, 7000.229974702778, 7031.367176954099, 6583.210014798159, 6590.373914478117, 6607.108040414579, 6656.500762442836, 6688.598684078874, 6441.581297215666, 6593.80218593443, 6695.230048544479, 6769.289224631343, 6773.322667733286, 6601.141851559267, 6678.933210667831, 6681.9331806682285, 6722.66386680664, 6729.49528785343, 6688.966555167291, 6763.492738044666, 6771.289014653489, 6781.796546103625, 6805.591664500146, 5142.51146141116, 5185.040767458032, 5207.71357575337, 5264.842054738364, 5282.2340760589495, 4545.704529205591, 4555.863324100283, 4566.109608626352, 4581.748003859753, 4602.907941841145, 5745.052066409079, 5776.855578610568, 5797.507211886952, 5825.592208545361, 5827.096799996008, 6542.443892269211, 6732.360425759545, 6747.190337159573, 6803.65981700913, 6823.28355522663, 5683.346415162309, 5725.627834190847, 5790.957627627067, 5820.417958204146, 5828.038373668382, 5820.970895145497, 5837.67892765902, 5841.912371314434, 5847.26909136358, 5862.70686465675, 6442.77450289247, 6589.769358072444, 6603.669816509156, 6622.602643841385, 6629.171353580802, 6758.3917447428, 6767.458603311723, 6843.7604683835825, 6863.485238607224, 6868.210155831944, 6316.0, 6336.08126821599, 6419.582727122722, 6452.451541619015, 6539.280679125388, 6484.157059582224, 6545.901811472737, 6581.572197807127, 6594.439472644879, 6595.505337099641, 6684.83287917806, 6691.130153080068, 6702.698378572878, 6708.262091170065, 6723.966380168264, 6520.608763474207, 6532.608043517404, 6534.411902928759, 6598.406143447113, 6602.6698665067515, 6450.516211284266, 6484.773032943825, 6498.3826536478955, 6559.048937903882, 6569.9343006569325, 6212.875742485035, 6347.904781428375, 6400.51996100285, 6530.151080359523, 6541.6075035498025, 6435.646039467687, 6453.16108905858, 6455.806325810233, 6537.182852143482, 6577.473802095917, 6169.660668663087, 6337.2395312562785, 6367.267764207176, 6410.134631824831, 6445.838854028687], "value": 6077.041933170157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.5080828523596, 857.5840717252136, 887.3699673232005, 912.1289168843755, 914.3371055984412, 39828.800855995716, 41455.58544414555, 41487.58512414875, 41512.16975660489, 41533.792331038305, 37819.81090094546, 37964.24071518575, 38230.42654360187, 38297.0, 38302.616973830256, 7303.671334789934, 7401.185869554345, 7410.2219266977, 7421.0, 7430.554166749986, 7260.891086633678, 7280.708771649128, 7284.0166577512155, 7286.162091359482, 7358.080239970004, 7329.047223860891, 7902.6443810028395, 8065.072516660601, 8079.232472915093, 8124.065732440757, 7987.480813747117, 7995.080565734927, 8021.2379823916635, 8046.476978996347, 8057.315128214109, 7942.205779422012, 7987.520748755035, 7995.920040799634, 8015.919840801634, 8042.959785201095, 38002.23995520102, 38046.0, 38226.0, 38492.23015539702, 38492.61507384946, 3503.281827225438, 3534.5051692762777, 3559.3059353426092, 3568.3041806847673, 3570.393033184365, 31409.528857067162, 31443.52834707481, 31496.685033149603, 31520.0, 31547.0, 5172.663776854492, 5188.092083885343, 5202.817901373433, 5214.713190774506, 5235.55497782689, 190729.0, 192356.0, 193562.0, 193911.0304448483, 194546.0, 48536.27195592069, 48863.755681221366, 48886.511134888904, 48991.75504122528, 49047.50952490429, 52274.47725522772, 52792.472075279526, 53431.19853202205, 53499.73250133725, 53584.0, 16225.35098596043, 16371.508854734377, 16426.0, 16466.6706665866, 16488.17559122039, 13412.463501459832, 13573.117747346589, 13617.523386681616, 13618.455261789615, 13660.316984150753, 14775.40898364075, 14784.926075369554, 14795.778063329059, 14832.0, 14903.105813650998, 5779.566532510079, 5875.148103524965, 5892.852678682982, 5922.822315330461, 5926.1999630049395, 992.2607657295362, 1000.2698030437821, 1002.5288114586133, 1005.190821388789, 1019.1337363241333, 23171.53656926852, 23265.06939722392, 23456.179033733737, 23621.0, 23775.405614859767, 1096.9341839489657, 1117.9888201117885, 1128.4075860173475, 1128.7460321427777, 1135.4493070860626, 12487.375631218403, 12577.93711031439, 12656.620301390973, 12704.745905081847, 12836.743265134644, 228350.0, 230221.0, 230663.0, 231930.0, 232543.0, 44538.554614454086, 45303.54696452993, 45508.3173752394, 52416.47583524192, 53093.73453132709, 1442.819647544057, 1449.1087980891675, 1452.3319273134266, 1459.1828575997263, 1459.6569806095347, 26658.543527872396, 26789.0, 27117.86441067782, 27213.591796122677, 27814.16557503278, 36900.81549592342, 37484.81257593694, 37526.0, 37752.05619859525, 37757.05607359838, 195781.0, 196058.0, 196120.0, 197247.0, 197322.0, 33950.830245848614, 34526.65473345234, 34591.13522161966, 34666.306673866886, 34691.47962780611, 42342.78828605837, 42858.357124642534, 43274.35088473612, 43417.78291108524, 43493.3475997854, 30953.845230773702, 31001.8449907749, 31502.842485787423, 31660.208494787814, 31679.36641267208, 30690.07929762111, 30879.69120308858, 31072.378552428374, 31146.0, 31400.0, 33991.32017359688, 34679.0, 34946.126346840516, 35324.11689707778, 35455.64544354523, 29668.40663186681, 30233.848830755705, 30543.0, 30864.691353086182, 30876.073717788502, 22311.553768924856, 22662.886685566467, 22847.657285141067, 22928.31215063551, 22974.310770676908], "value": 17213.041946838828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3768716724438, 582.871768210994, 590.1472372421853, 599.9010163323052, 618.4557589321397, 21759.67360489592, 22376.552468950613, 22624.43438914026, 22708.0, 22725.772742272573, 22872.88563557184, 24117.51764964704, 24347.87826060867, 24602.630960535607, 24612.384690382703, 6440.677966101688, 6565.474762019027, 6619.702113404908, 6621.635810030446, 6631.0, 6440.710168042449, 6504.544681872271, 6539.836504087412, 6557.967210163966, 6563.638999855006, 7004.929950700504, 7319.085114360705, 7322.890156647654, 7331.193568707438, 7333.486655934087, 7204.56772593646, 7219.963900180518, 7241.855162896739, 7283.927160728378, 7287.927120728805, 7041.190263119755, 7084.822879428004, 7112.466565007645, 7135.928640713631, 7151.106111736033, 28171.85914070437, 29466.0, 29489.410211795857, 29598.852005739835, 29683.257918551993, 2139.7432308123125, 2144.9811339613716, 2154.7522034966023, 2164.3615133535645, 2189.7262842144733, 19343.80656193434, 19698.80301196984, 20060.29788957394, 20064.498387540283, 20097.799022009738, 2527.128140791424, 2574.1633968959977, 2588.715241323453, 2610.4387556675406, 2610.69976952651, 127238.0, 129346.0, 132545.0, 138728.61271387257, 140520.2973985134, 19414.611707765765, 20183.275257840003, 21055.368338949855, 22064.0, 22322.55354892893, 40370.59629403727, 40637.0, 40718.796406017784, 40754.18491630151, 41134.177316453504, 11410.258333208314, 11425.143114266462, 11436.142289328334, 11458.166693329027, 11588.0, 9392.154706076486, 9413.341066125442, 9533.761655958657, 9616.471094089753, 9672.661456848977, 10428.530716117793, 10474.528646210938, 11015.83476247857, 11145.66252049743, 11148.386838723785, 3687.317846198408, 3719.6466335698065, 4160.649233183302, 4183.267928112568, 4379.737215767001, 954.0030667952007, 976.6142373762466, 985.6599473181741, 991.7718924647371, 992.8609994600762, 18598.16308266104, 18611.627767444847, 18784.342548010754, 18947.43157705271, 19189.904050479938, 1026.1175389165312, 1038.8493668418037, 1047.3611097230682, 1048.4495639789172, 1052.7315534538643, 10337.22470814692, 10514.0, 10589.470526473646, 10599.788004240027, 10964.835527467094, 485571.0, 491112.0, 506928.0, 510564.0, 512755.0, 107350.46324768326, 108282.0, 115072.42463787795, 116549.4172529149, 119162.0, 1141.5148561861176, 1162.0529268646196, 1183.9112066594867, 1186.821976703484, 1190.0301254477572, 16884.155792210095, 17012.74480882763, 17019.23413446373, 17159.57101072483, 17238.827611723722, 54673.179902300704, 55417.722911385186, 56273.15590266068, 56963.715181423824, 57063.0, 69660.30339696538, 70245.29754702593, 70556.29443705497, 71973.0, 72239.0, 19168.849869007903, 19186.232550697816, 19255.51861203481, 19435.222591096197, 19505.70741438851, 22304.330870073925, 22449.0, 22518.211862584732, 22561.210357637403, 22685.75228362456, 16214.108224047319, 16228.350865965229, 17367.739483908004, 17460.91269543644, 17999.19003644813, 16019.839801601835, 16050.277737501607, 16079.839201607834, 16300.021998680117, 16325.918370408071, 16369.590760231089, 16717.414890478776, 18086.81913180904, 18458.0, 18496.81503184951, 17880.0, 19045.14296856617, 19100.90449547799, 19113.80886191176, 19117.61764764669, 16917.74623380675, 17162.0, 17173.742393863853, 17336.306547738455, 17504.649907002044], "value": 12718.18206152315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.782070958292, 1374.505178135871, 1374.6357215337944, 1375.717977814548, 1386.2722070912773, 15128.319225634845, 15812.734981201505, 15905.602359940993, 15939.203039848018, 15967.760483592741, 15584.142872142027, 15740.134292613902, 15785.21073946301, 15798.131102789343, 15800.84199158008, 2735.8221715588425, 2755.917322480329, 2811.9718802811913, 2812.929676758087, 2814.5074611942932, 2732.79504037197, 2760.1167626359475, 2764.4471105778825, 2770.0858716623466, 2791.4556661451024, 2593.455374371384, 2719.809613327068, 2770.9584356234673, 2771.8198317109423, 2772.792040596953, 2743.4513097380604, 2751.7798576113864, 2790.441911617664, 2812.086072026589, 2815.845128517931, 2358.4457652451833, 2437.5612389769835, 2689.8789554470095, 2724.768394686454, 2731.0, 12586.37068146589, 12727.299998500079, 14743.0, 15301.08193508393, 15309.0, 8015.47899386538, 8297.626606802649, 8306.127856575093, 8334.62494187757, 8338.166183381674, 5164.1995490699, 5279.894402111975, 5468.535174510172, 5472.288602481652, 5475.863103422446, 1918.194358369488, 1953.1894263880472, 1956.461972957448, 1991.2433275355418, 1992.3524854422371, 26813.597796033075, 27591.034313798922, 27606.0, 27624.171274861586, 27658.723412765816, 7128.683177967077, 7144.714211431485, 7193.820154496179, 7395.297446742551, 7468.850622987618, 20520.794792052187, 20572.38282851517, 20616.278430254868, 20665.690014649794, 20731.58536829285, 8053.1946805319, 8228.259456648811, 8252.298554622925, 8269.710560130367, 8295.8340833183, 7113.608751518716, 7373.963130184422, 7390.22402647725, 7438.516496427715, 7529.962350188323, 5571.554275657938, 5758.1650660654805, 5764.884702305931, 5806.564507661942, 5821.76712931478, 1741.2077504735314, 1770.4954088085092, 1794.5244510204807, 1805.9638807223782, 1816.8364847163818, 888.3559419420868, 902.1745103230471, 918.0589895357313, 930.3208657679796, 932.3380399916135, 7633.580153091633, 7813.10149332834, 8617.95691021541, 8789.077146899612, 8814.77963050916, 719.7624783821326, 739.6893304811991, 745.3701622129292, 748.6256871564218, 752.9058867641545, 5292.655977361459, 5453.945460545344, 5456.972715136399, 5536.695481748462, 5606.24315717373, 21228.363149105553, 21391.46521336948, 21803.67294490584, 21950.780492195194, 22403.55192896133, 21865.781342186692, 21887.671684924422, 21903.0, 22149.66775498369, 22555.774442255366, 11377.601783937522, 11446.14153938458, 11666.358350290815, 11700.35648039349, 11874.643760687193, 8433.536155511505, 8485.066642669424, 8489.957550212457, 8563.95718021406, 8598.61306241233, 17880.374186903395, 18294.542636434195, 19219.0, 19234.80765192386, 19418.90290548538, 19144.425667230007, 19177.424677259703, 19512.414627561197, 19710.90144549268, 19803.504912377306, 12506.499740010298, 12613.243205407705, 12653.87346126527, 12705.872941270838, 12727.87272127304, 13881.930590346983, 13938.442462301395, 14044.929775351058, 14063.578092657237, 14152.92923535417, 10763.300385474919, 11422.428878555873, 11443.542258309908, 11443.771124577295, 11592.246503977214, 10536.209784266057, 10766.623168189075, 10835.566577336818, 11031.22781405294, 11039.06167975699, 9704.75738106553, 9717.465539395402, 9811.920688724378, 9865.26010549226, 9873.901260987299, 7078.362947334765, 7245.203027666847, 7249.601271930094, 7280.271972802678, 7293.854122917406, 7623.0, 7665.8466830661955, 7702.691892324245, 7736.7292144774665, 7745.341645960157], "value": 6818.522526393699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.5312312672343, 510.76249543962064, 538.0, 538.359352370679, 549.8240563019833, 6240.43836054755, 6277.489004398243, 6279.780207692732, 6292.528060395472, 6356.427921487065, 6203.286622038456, 6224.315325314223, 6266.8406344826235, 6278.403551662596, 6311.463525600329, 5176.3176967485715, 5195.168772996321, 5247.553957913582, 5267.55225805807, 5293.338332708411, 5230.555402790767, 5255.894882102356, 5257.1851363038595, 5316.813911513098, 5342.839714808562, 5113.514216149479, 5149.81975630853, 5244.108501554745, 5289.814856480024, 5296.973515132419, 5178.171492561191, 5221.947780522184, 5267.815626453094, 5279.894402111936, 5284.5243928046275, 4875.195592727196, 4879.829205977774, 4883.755812209411, 4917.286993385975, 4933.284673722326, 5968.313643930916, 6184.8763024739255, 6239.65681887496, 6255.40573645503, 6258.092576576417, 5976.820695379146, 6051.394860513958, 6053.969730151365, 6084.0, 6119.0, 6616.503762217805, 6617.0, 6632.80101596948, 6660.400563949268, 6671.93328066718, 5038.193888977783, 5320.866978325535, 5326.617597825409, 5344.278522399465, 5358.46415358461, 6841.452683785285, 6871.278515755874, 6952.323355508115, 7003.544769590011, 7018.859622807515, 5450.700211488406, 5473.9452605474235, 5484.067708489566, 5538.864532770773, 5555.194496798023, 5596.552275817925, 5642.0, 5653.943460565341, 5657.377688454267, 5672.355017045011, 5959.970200148971, 6012.909806352908, 6054.8183554493435, 6105.267367915879, 6135.202423684982, 6653.234877988996, 6727.562708423937, 6767.39093481589, 6781.796546103625, 6790.253072162058, 1961.3429501117, 1963.8232559069752, 1976.2885361269932, 1979.7921218272163, 2000.549876277855, 1384.4254634326844, 1423.843377228504, 1426.7788492783427, 1471.919044452544, 1482.6738117614107, 5526.613137080366, 5611.663300201919, 5621.381648018714, 5709.65742055478, 5720.170575266563, 6679.0, 6689.264180940093, 6699.363560461748, 6705.228898676617, 6749.257581666013, 5591.944080559224, 5607.82235730493, 5710.229119068956, 5725.828225153252, 5789.334226563915, 3516.7538272320694, 3528.2767032758225, 3541.5218945442552, 3553.857845686195, 3582.3193593217725, 6480.222373315232, 6506.794564348502, 6557.606543607303, 6558.868822623521, 6560.278369379364, 6883.827904302432, 6908.481863860231, 6928.965355173192, 6939.340762627542, 6955.756548520778, 6326.0, 6379.393957574116, 6409.327020662857, 6428.325025872309, 6449.677516124175, 6510.902336465051, 6587.945928651393, 6617.338266173344, 6623.416867421805, 6632.966835165793, 6459.935400645933, 6509.544331896722, 6558.409743123142, 6620.834479137868, 6638.50211234169, 6315.410681620514, 6329.303776584664, 6355.569996750879, 6451.870882608634, 6480.449161821298, 5442.346918369821, 5476.424975377528, 5488.4785945335125, 5515.365732940763, 5548.195511650707, 6315.315990704024, 6512.47900167976, 6650.467962562887, 6707.765228217184, 6786.626735529593, 6414.647194404352, 6444.097826304415, 6447.742090316522, 6470.773522926675, 6507.772227971998, 6449.355064493513, 6450.000249961264, 6450.322716114928, 6509.707063182263, 6581.243157037002, 6285.277193122849, 6301.4328710416285, 6360.681965901594, 6365.684653314534, 6385.892655423606, 6470.320616335405, 6558.311377305315, 6573.107832553661, 6604.3725846044545, 6615.4376877965915, 6288.591241569284, 6309.400606942333, 6349.904751428825, 6389.744410223539, 6395.712192951235], "value": 5205.1995987293185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.8535041718114, 894.3515950935573, 909.9454032758035, 911.2482202183196, 913.4519288426941, 16564.254608542615, 16671.41650042249, 16770.329186832543, 16881.40915067973, 16955.491335259932, 18386.632267354646, 18636.906815465903, 18638.906805465955, 18662.626747465078, 18672.25310987559, 952.2572393533021, 974.3569244298765, 976.9218462522981, 977.4184360305607, 978.0512902484578, 982.5971351745785, 982.8378317577591, 983.2969426859794, 983.306768728045, 984.3650845204838, 990.1237404896647, 1007.9848802267935, 1009.6314845081566, 1028.609128531157, 1037.1547189040946, 985.2265971212564, 990.1484723138095, 993.7813680990171, 1003.0070230471816, 1003.1573478278245, 733.1312394812164, 737.7823542055053, 741.6884908338511, 743.5464366736287, 744.9813754656122, 19654.0, 20238.898805506025, 20342.898285508625, 20385.18459261628, 20386.69419958702, 21896.45258868541, 22069.889650551646, 22520.54958900813, 22707.545849082926, 22711.545769084525, 16379.262933168036, 16627.41804036865, 16657.33370665184, 16792.832071679248, 16918.915405423017, 3775.716821238391, 3781.4894989176382, 3792.7534710243744, 3807.200487897545, 3811.656950874407, 100561.0, 134190.0, 135754.32122839324, 138825.0, 140087.29956350152, 15874.126923019345, 16353.672926541403, 16366.672666546603, 16381.262843172086, 16437.83562164387, 31192.532112018336, 31733.682663173535, 32003.51994720081, 32094.518582221284, 32168.0, 8709.520976346363, 8752.8687069694, 8819.29445644347, 8842.734717958472, 8846.557672116369, 3762.285165818486, 3988.7008474363956, 3989.401589761501, 4015.738976966488, 4016.3774614934146, 5477.0, 5573.749181286771, 5588.86027849307, 5605.159226116034, 5607.719614019283, 1019.8623185869961, 1053.8840727519967, 1056.27645063132, 1061.554147258138, 1070.844727514506, 609.768288050538, 635.8505751148476, 641.9325970773095, 654.8821212181758, 657.6974591687878, 11447.771044579229, 11531.769364612828, 12013.339266340436, 12709.0, 13170.60488185356, 672.3008071605476, 678.7815870512442, 690.0270618427993, 691.381213813634, 700.870338987289, 5436.510714035756, 5468.863278417992, 5571.164325351229, 5573.303337082864, 5587.972060139755, 118620.40689796496, 120123.0, 122281.38859305647, 123662.38168809099, 126642.0, 108389.0, 108457.0, 109146.90853091526, 111781.0, 113006.0, 90369.0, 93798.0620193803, 94268.52865735764, 94525.58211626831, 94937.52531237299, 10348.637797677045, 10371.533281002223, 10380.221483388927, 10441.738956526147, 10653.57385704563, 43833.0, 44711.0, 45975.77012114918, 46163.76918115388, 46783.76608116938, 57891.0, 59112.40887591241, 59300.40699592949, 59394.0, 60097.098543522756, 15912.681746365239, 15930.283137259083, 15985.360585576447, 16113.113778742281, 16129.193540323171, 15782.36870525212, 16042.598935026252, 16048.518544443685, 16095.919520402324, 16136.273867676218, 14837.183954882585, 14873.405063797327, 14904.925475372555, 15048.322825473098, 15168.696626067638, 15168.924155379153, 15467.303971321542, 15556.0, 15574.0, 15693.372265109725, 15160.393584256506, 15252.084874907541, 15396.0, 15422.228888555752, 15490.690186196438, 11492.712682182679, 11606.825897611712, 11635.360055197045, 11990.160688751703, 12029.218100823418, 11636.196389559631, 11644.941775291069, 11893.702657433634, 11922.284662920252, 12096.818547721967], "value": 8813.415475311387, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 101.0, 112.0, 109.0, 107.0, 114.0, 107.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 116.0, 117.0, 116.0, 118.0, 120.0, 116.0, 122.0, 117.0, 123.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 170.0, 169.0, 172.0, 168.0, 174.0, 175.0, 172.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 77.0, 76.0, 82.0, 77.0, 79.0, 78.0, 84.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 86.0, 84.0, 85.0, 79.0, 89.0, 79.0, 89.0, 79.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 114.0, 114.0, 114.0, 115.0, 111.0, 115.0, 118.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 152.0, 155.0, 149.0, 150.0, 150.0, 150.0, 150.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 97.0, 94.0, 95.0, 95.0, 101.0, 97.0, 97.0, 102.0, 96.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 55.0, 54.0, 57.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 39.0, 39.0, 39.0, 45.0, 51.0, 47.0, 48.0, 38.0, 46.0], "value": 44.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 79.0, 79.0, 73.0, 74.0, 74.0, 78.0, 78.0, 78.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 121.0, 110.0, 116.0, 116.0, 112.0, 110.0, 117.0, 118.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 175.0, 169.0, 170.0, 166.0, 181.0, 172.0, 166.0, 176.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 68.0, 61.0, 69.0, 67.0, 67.0, 66.0, 67.0, 64.0], "value": 66.5, "unit": "score"}]}]} 04:13:06 INFO - Return code: 0 04:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:06 INFO - # TBPL SUCCESS # 04:13:06 INFO - Running post-action listener: _package_coverage_data 04:13:06 INFO - Running post-action listener: _resource_record_post_action 04:13:06 INFO - [mozharness: 2017-09-26 11:13:06.594601Z] Finished run-tests step (success) 04:13:06 INFO - Running post-run listener: _resource_record_post_run 04:13:06 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 6963200; Write bytes: 339709952; Read time: 4064; Write time: 248452 04:13:06 INFO - TinderboxPrint: CPU usage
13.3% 04:13:06 INFO - TinderboxPrint: I/O read bytes / time
6,963,200 / 4,064 04:13:06 INFO - TinderboxPrint: I/O write bytes / time
339,709,952 / 248,452 04:13:06 INFO - TinderboxPrint: CPU idle
8,254.3 (86.7%) 04:13:06 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 04:13:06 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13459456; Read time: 0; Write time: 1064 04:13:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:13:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6959104; Write bytes: 326250496; Read time: 4052; Write time: 247388 04:13:07 INFO - Running post-run listener: _upload_blobber_files 04:13:07 INFO - Blob upload gear active. 04:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:07 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 04:13:07 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'] 04:13:07 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 04:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:08 INFO - (blobuploader) - INFO - Done attempting. 04:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:09 INFO - (blobuploader) - INFO - Done attempting. 04:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:10 INFO - (blobuploader) - INFO - Done attempting. 04:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:13 INFO - (blobuploader) - INFO - Done attempting. 04:13:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:13 INFO - Return code: 0 04:13:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/575107017031b6e55fe6176221c2f9190ad2343791a6681785ef04f5645a2c7589df451283fd2d71f2b04bb2ca19f0b73667efd7fadfeb069e65784d97fa5c87", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08252038285f847c27583e571e96eb0514ccaebc32955a3f53fffbe6d9be85e8a6d7dca0110f29b2e41c85a019a411610c15b6b961b5a0a8b0b15c3aed287403", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e57c51354a9d81b792bec9accfe3f34b5dd6137c0ea9b9a07552c60e7d33615650c05ceac56f13419bf3fdf418273f1ecbce459bc963bd83cf9e91e2816255", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48955c9471c0dd4fa5d422a01ec08fc6885cf1f02f93c312c910a207b7ec3b57166699ccdf9d87cdab39aeac573f4d956b3f642bbb33eb4f7fd3915d76f23bc"} 04:13:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:13 INFO - Contents: 04:13:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/575107017031b6e55fe6176221c2f9190ad2343791a6681785ef04f5645a2c7589df451283fd2d71f2b04bb2ca19f0b73667efd7fadfeb069e65784d97fa5c87", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08252038285f847c27583e571e96eb0514ccaebc32955a3f53fffbe6d9be85e8a6d7dca0110f29b2e41c85a019a411610c15b6b961b5a0a8b0b15c3aed287403", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e57c51354a9d81b792bec9accfe3f34b5dd6137c0ea9b9a07552c60e7d33615650c05ceac56f13419bf3fdf418273f1ecbce459bc963bd83cf9e91e2816255", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48955c9471c0dd4fa5d422a01ec08fc6885cf1f02f93c312c910a207b7ec3b57166699ccdf9d87cdab39aeac573f4d956b3f642bbb33eb4f7fd3915d76f23bc"} 04:13:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:13 INFO - Copying logs to upload dir... 04:13:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.569308 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-26 04:13:14.071685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:13:14.076209) ========= 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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 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/575107017031b6e55fe6176221c2f9190ad2343791a6681785ef04f5645a2c7589df451283fd2d71f2b04bb2ca19f0b73667efd7fadfeb069e65784d97fa5c87", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08252038285f847c27583e571e96eb0514ccaebc32955a3f53fffbe6d9be85e8a6d7dca0110f29b2e41c85a019a411610c15b6b961b5a0a8b0b15c3aed287403", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e57c51354a9d81b792bec9accfe3f34b5dd6137c0ea9b9a07552c60e7d33615650c05ceac56f13419bf3fdf418273f1ecbce459bc963bd83cf9e91e2816255", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48955c9471c0dd4fa5d422a01ec08fc6885cf1f02f93c312c910a207b7ec3b57166699ccdf9d87cdab39aeac573f4d956b3f642bbb33eb4f7fd3915d76f23bc"} build_url:https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/PCiGiK1VQh2s6A_KoXCpVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/575107017031b6e55fe6176221c2f9190ad2343791a6681785ef04f5645a2c7589df451283fd2d71f2b04bb2ca19f0b73667efd7fadfeb069e65784d97fa5c87", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08252038285f847c27583e571e96eb0514ccaebc32955a3f53fffbe6d9be85e8a6d7dca0110f29b2e41c85a019a411610c15b6b961b5a0a8b0b15c3aed287403", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e57c51354a9d81b792bec9accfe3f34b5dd6137c0ea9b9a07552c60e7d33615650c05ceac56f13419bf3fdf418273f1ecbce459bc963bd83cf9e91e2816255", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48955c9471c0dd4fa5d422a01ec08fc6885cf1f02f93c312c910a207b7ec3b57166699ccdf9d87cdab39aeac573f4d956b3f642bbb33eb4f7fd3915d76f23bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:13:14.108083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:13:14.108504) ========= 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=7de08804244eb36560b44971000001c3-1506410374.200797-1290141514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:13:14.164691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:13:14.165026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:13:14.165360) ========= ========= Total master_lag: 0.34 =========