builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1506555919.5 results: success (0) revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.502092) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.502549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.502825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.520762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.521178) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 16:45:19-- 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% 108M=0s 2017-09-27 16:45:19 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.369874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.908514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.908859) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020051 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.958596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:19.958959) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 69e3f89816455e567f1a20b694fd6afd549c82c7 --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 69e3f89816455e567f1a20b694fd6afd549c82c7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 16:45:20,013 truncating revision to first 12 chars 2017-09-27 16:45:20,013 Setting DEBUG logging. 2017-09-27 16:45:20,013 attempt 1/10 2017-09-27 16:45:20,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/69e3f8981645?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 16:45:20,604 unpacking tar archive at: mozilla-central-69e3f8981645/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:20.911652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:20.911977) ========= script_repo_revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:20.912374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:20.912662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 16:45:20.927472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 16:45:20.928104) ========= /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=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:21 INFO - MultiFileLogger online at 20170927 16:45:21 in /builds/slave/test 16:45:21 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 16:45:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:21 INFO - {'append_to_log': False, 16:45:21 INFO - 'base_work_dir': '/builds/slave/test', 16:45:21 INFO - 'blob_upload_branch': 'Firefox', 16:45:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:21 INFO - 'branch': 'Firefox', 16:45:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:21 INFO - 'code_coverage': False, 16:45:21 INFO - 'config_files': ('talos/linux_config.py',), 16:45:21 INFO - 'default_actions': ('clobber', 16:45:21 INFO - 'read-buildbot-config', 16:45:21 INFO - 'download-and-extract', 16:45:21 INFO - 'populate-webroot', 16:45:21 INFO - 'create-virtualenv', 16:45:21 INFO - 'install', 16:45:21 INFO - 'setup-mitmproxy', 16:45:21 INFO - 'run-tests'), 16:45:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:21 INFO - 'disable_ccov_upload': False, 16:45:21 INFO - 'disable_stylo': False, 16:45:21 INFO - 'download_minidump_stackwalk': True, 16:45:21 INFO - 'download_symbols': 'ondemand', 16:45:21 INFO - 'enable_stylo': False, 16:45:21 INFO - 'enable_webrender': False, 16:45:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:45:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:21 INFO - 'gecko_profile': False, 16:45:21 INFO - 'gecko_profile_interval': 0, 16:45:21 INFO - 'installer_path': 'installer.exe', 16:45:21 INFO - 'log_level': 'info', 16:45:21 INFO - 'log_name': 'talos', 16:45:21 INFO - 'log_to_console': True, 16:45:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:21 INFO - 'opt_config_files': (), 16:45:21 INFO - 'pip_index': False, 16:45:21 INFO - 'suite': 'dromaeojs-e10s', 16:45:21 INFO - 'system_bits': '32', 16:45:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:21 INFO - 'title': 'talos-linux64-ix-084', 16:45:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:21 INFO - 'use_talos_json': True, 16:45:21 INFO - 'verify': 'False', 16:45:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:21 INFO - 'work_dir': 'build'} 16:45:21 INFO - [mozharness: 2017-09-27 23:45:21.124420Z] Running clobber step. 16:45:21 INFO - Running pre-action listener: _resource_record_pre_action 16:45:21 INFO - Running main action method: clobber 16:45:21 INFO - rmtree: /builds/slave/test/build 16:45:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:22 INFO - Running post-action listener: _resource_record_post_action 16:45:22 INFO - [mozharness: 2017-09-27 23:45:22.134115Z] Finished clobber step (success) 16:45:22 INFO - [mozharness: 2017-09-27 23:45:22.134212Z] Running read-buildbot-config step. 16:45:22 INFO - Running pre-action listener: _resource_record_pre_action 16:45:22 INFO - Running main action method: read_buildbot_config 16:45:22 INFO - Using buildbot properties: 16:45:22 INFO - { 16:45:22 INFO - "project": "", 16:45:22 INFO - "product": "firefox", 16:45:22 INFO - "who": "archaeopteryx@coole-files.de", 16:45:22 INFO - "installer_path": "public/build/target.tar.bz2", 16:45:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:45:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:45:22 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:45:22 INFO - "stage_platform": "linux64-qr", 16:45:22 INFO - "basedir": "/builds/slave/test", 16:45:22 INFO - "buildnumber": 89, 16:45:22 INFO - "platform": "ubuntu64_hw_qr", 16:45:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:45:22 INFO - "slavebuilddir": "test", 16:45:22 INFO - "taskId": "ST6aBNFSTs-reon_R9Kz3A", 16:45:22 INFO - "branch": "mozilla-central", 16:45:22 INFO - "script_repo_revision": "production", 16:45:22 INFO - "revision": "69e3f89816455e567f1a20b694fd6afd549c82c7", 16:45:22 INFO - "slavename": "talos-linux64-ix-084", 16:45:22 INFO - "repo_path": "mozilla-central" 16:45:22 INFO - } 16:45:22 INFO - Finding installer, test and symbols from parent task. 16:45:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ST6aBNFSTs-reon_R9Kz3A'}, attempt #1 16:45:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ST6aBNFSTs-reon_R9Kz3A'}, attempt #1 16:45:23 INFO - Task dependencies: dp8k4SKiS8qEBmLBTOvhFQ 16:45:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ'}, attempt #1 16:45:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:45:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json 16:45:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip 16:45:23 INFO - Running post-action listener: _resource_record_post_action 16:45:23 INFO - [mozharness: 2017-09-27 23:45:23.599645Z] Finished read-buildbot-config step (success) 16:45:23 INFO - [mozharness: 2017-09-27 23:45:23.599867Z] Running download-and-extract step. 16:45:23 INFO - Running pre-action listener: _resource_record_pre_action 16:45:23 INFO - Running main action method: download_and_extract 16:45:23 INFO - mkdir: /builds/slave/test/build/tests 16:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:23 INFO - trying https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json 16:45:23 INFO - Downloading https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:45:24 INFO - Downloaded 989 bytes. 16:45:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:45:24 INFO - Using the following test package requirements: 16:45:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:45:24 INFO - u'common': [u'target.common.tests.zip'], 16:45:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:45:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:45:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:45:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:45:24 INFO - u'mozbase': [u'target.common.tests.zip'], 16:45:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:45:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:45:24 INFO - u'web-platform': [u'target.common.tests.zip', 16:45:24 INFO - u'target.web-platform.tests.tar.gz'], 16:45:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:45:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:45:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip 16:45:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:45:24 INFO - Fetch https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip into memory 16:45:25 INFO - Content-Length response header: 54945885 16:45:25 INFO - Bytes received: 54945885 16:45:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip 16:45:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:45:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip into memory 16:45:36 INFO - Content-Length response header: 14513779 16:45:36 INFO - Bytes received: 14513779 16:45:36 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')]} 16:45:36 INFO - trying https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:45:36 INFO - Downloading https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:45:38 INFO - Downloaded 61765788 bytes. 16:45:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:45:38 INFO - mkdir: /builds/slave/test/properties 16:45:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:38 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:38 INFO - Contents: 16:45:38 INFO - build_url:https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:45:38 INFO - Running post-action listener: _resource_record_post_action 16:45:38 INFO - Running post-action listener: find_tests_for_verification 16:45:38 INFO - Running post-action listener: set_extra_try_arguments 16:45:38 INFO - [mozharness: 2017-09-27 23:45:38.420094Z] Finished download-and-extract step (success) 16:45:38 INFO - [mozharness: 2017-09-27 23:45:38.420326Z] Running populate-webroot step. 16:45:38 INFO - Running pre-action listener: _resource_record_pre_action 16:45:38 INFO - Running main action method: populate_webroot 16:45:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:45:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['tresize', 16:45:38 INFO - 'tcanvasmark']}, 16:45:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:45:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['dromaeo_css', 16:45:38 INFO - 'kraken']}, 16:45:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'tests': ['damp', 'tps']}, 16:45:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['damp', 'tps']}, 16:45:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['dromaeo_dom']}, 16:45:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:45:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['basic_compositor_video', 16:45:38 INFO - 'glvideo']}, 16:45:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:45:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['ts_paint_webext', 16:45:38 INFO - 'tp5o_webext']}, 16:45:38 INFO - 'other-e10s': {'tests': ['a11yr', 16:45:38 INFO - 'ts_paint', 16:45:38 INFO - 'tpaint', 16:45:38 INFO - 'sessionrestore', 16:45:38 INFO - 'sessionrestore_many_windows', 16:45:38 INFO - 'sessionrestore_no_auto_restore', 16:45:38 INFO - 'tabpaint']}, 16:45:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['a11yr', 16:45:38 INFO - 'ts_paint', 16:45:38 INFO - 'tpaint', 16:45:38 INFO - 'sessionrestore', 16:45:38 INFO - 'sessionrestore_many_windows', 16:45:38 INFO - 'sessionrestore_no_auto_restore', 16:45:38 INFO - 'tabpaint']}, 16:45:38 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:45:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:45:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['perf_reftest_singletons']}, 16:45:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['perf_reftest']}, 16:45:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:45:38 INFO - 'tsvgr_opacity', 16:45:38 INFO - 'tart', 16:45:38 INFO - 'tscrollx', 16:45:38 INFO - 'tsvg_static']}, 16:45:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['tsvgx', 16:45:38 INFO - 'tsvgr_opacity', 16:45:38 INFO - 'tart', 16:45:38 INFO - 'tscrollx', 16:45:38 INFO - 'tsvg_static']}, 16:45:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:45:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--disable-stylo'], 16:45:38 INFO - 'tests': ['tp5o']}, 16:45:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:45:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:45:38 INFO - 'talos_options': ['--mitmproxy', 16:45:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:45:38 INFO - '--firstNonBlankPaint'], 16:45:38 INFO - 'tests': ['tp6_google', 16:45:38 INFO - 'tp6_youtube', 16:45:38 INFO - 'tp6_amazon', 16:45:38 INFO - 'tp6_facebook']}, 16:45:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:45:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:45:38 INFO - 'talos_options': ['--disable-stylo', 16:45:38 INFO - '--mitmproxy', 16:45:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:45:38 INFO - '--firstNonBlankPaint'], 16:45:38 INFO - 'tests': ['tp6_google', 16:45:38 INFO - 'tp6_youtube', 16:45:38 INFO - 'tp6_amazon', 16:45:38 INFO - 'tp6_facebook']}, 16:45:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:45:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:45:38 INFO - 'talos_options': ['--stylo-threads=1', 16:45:38 INFO - '--mitmproxy', 16:45:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:45:38 INFO - '--firstNonBlankPaint'], 16:45:38 INFO - 'tests': ['tp6_google', 16:45:38 INFO - 'tp6_youtube', 16:45:38 INFO - 'tp6_amazon', 16:45:38 INFO - 'tp6_facebook']}, 16:45:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--xperf_path', 16:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:38 INFO - 'tests': ['tp5n']}, 16:45:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:45:38 INFO - 'talos_options': ['--disable-stylo', 16:45:38 INFO - '--xperf_path', 16:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:38 INFO - 'tests': ['tp5n']}}} 16:45:38 INFO - Running post-action listener: _resource_record_post_action 16:45:38 INFO - [mozharness: 2017-09-27 23:45:38.444739Z] Finished populate-webroot step (success) 16:45:38 INFO - [mozharness: 2017-09-27 23:45:38.444839Z] Running create-virtualenv step. 16:45:38 INFO - Running pre-action listener: _resource_record_pre_action 16:45:38 INFO - Running main action method: create_virtualenv 16:45:38 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:45:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:45:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:45:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:39 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:39 INFO - Installing pip...............done. 16:45:39 INFO - Return code: 0 16:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:45:39 INFO - Reading from file tmpfile_stdout 16:45:39 INFO - Output received: 16:45:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:45:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45:39 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')]} 16:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:39 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')]} 16:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:39 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:39 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 16:45:39 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 16:45:39 INFO - Using env: {'DISPLAY': ':0', 16:45:39 INFO - 'HOME': '/home/cltbld', 16:45:39 INFO - 'LANG': 'en_US.UTF-8', 16:45:39 INFO - 'LANGUAGE': 'en_US:en', 16:45:39 INFO - 'LOGNAME': 'cltbld', 16:45:39 INFO - 'MAIL': '/var/mail/cltbld', 16:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:39 INFO - 'MOZ_NO_REMOTE': '1', 16:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:39 INFO - 'NO_EM_RESTART': '1', 16:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:39 INFO - 'PWD': '/builds/slave/test', 16:45:39 INFO - 'SHELL': '/bin/bash', 16:45:39 INFO - 'SHLVL': '1', 16:45:39 INFO - 'TERM': 'linux', 16:45:39 INFO - 'TMOUT': '86400', 16:45:39 INFO - 'USER': 'cltbld', 16:45:39 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:39 INFO - '_': '/tools/buildbot/bin/python'} 16:45:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:45:40 INFO - Downloading/unpacking pip>=1.5 16:45:40 INFO - Running setup.py egg_info for package pip 16:45:40 INFO - warning: no files found matching 'pip/cacert.pem' 16:45:40 INFO - warning: no files found matching '*.html' under directory 'docs' 16:45:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:45:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:45:40 INFO - Installing collected packages: pip 16:45:40 INFO - Found existing installation: pip 1.1 16:45:40 INFO - Uninstalling pip: 16:45:40 INFO - Successfully uninstalled pip 16:45:40 INFO - Running setup.py install for pip 16:45:40 INFO - warning: no files found matching 'pip/cacert.pem' 16:45:40 INFO - warning: no files found matching '*.html' under directory 'docs' 16:45:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:45:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:45:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Successfully installed pip 16:45:40 INFO - Cleaning up... 16:45:40 INFO - Return code: 0 16:45:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:40 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:40 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 16:45:40 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 16:45:40 INFO - Using env: {'DISPLAY': ':0', 16:45:40 INFO - 'HOME': '/home/cltbld', 16:45:40 INFO - 'LANG': 'en_US.UTF-8', 16:45:40 INFO - 'LANGUAGE': 'en_US:en', 16:45:40 INFO - 'LOGNAME': 'cltbld', 16:45:40 INFO - 'MAIL': '/var/mail/cltbld', 16:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:40 INFO - 'MOZ_NO_REMOTE': '1', 16:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:40 INFO - 'NO_EM_RESTART': '1', 16:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:40 INFO - 'PWD': '/builds/slave/test', 16:45:40 INFO - 'SHELL': '/bin/bash', 16:45:40 INFO - 'SHLVL': '1', 16:45:40 INFO - 'TERM': 'linux', 16:45:40 INFO - 'TMOUT': '86400', 16:45:40 INFO - 'USER': 'cltbld', 16:45:40 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:40 INFO - '_': '/tools/buildbot/bin/python'} 16:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:40 INFO - Downloading/unpacking psutil>=3.1.1 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:42 INFO - Installing collected packages: psutil 16:45:42 INFO - Running setup.py install for psutil 16:45:42 INFO - building 'psutil._psutil_linux' extension 16:45:42 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 16:45:42 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 16:45:42 INFO - building 'psutil._psutil_posix' extension 16:45:42 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 16:45:42 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 16:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:42 INFO - Successfully installed psutil 16:45:42 INFO - Cleaning up... 16:45:42 INFO - Return code: 0 16:45:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:45:42 INFO - Using env: {'DISPLAY': ':0', 16:45:42 INFO - 'HOME': '/home/cltbld', 16:45:42 INFO - 'LANG': 'en_US.UTF-8', 16:45:42 INFO - 'LANGUAGE': 'en_US:en', 16:45:42 INFO - 'LOGNAME': 'cltbld', 16:45:42 INFO - 'MAIL': '/var/mail/cltbld', 16:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:42 INFO - 'MOZ_NO_REMOTE': '1', 16:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:42 INFO - 'NO_EM_RESTART': '1', 16:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:42 INFO - 'PWD': '/builds/slave/test', 16:45:42 INFO - 'SHELL': '/bin/bash', 16:45:42 INFO - 'SHLVL': '1', 16:45:42 INFO - 'TERM': 'linux', 16:45:42 INFO - 'TMOUT': '86400', 16:45:42 INFO - 'USER': 'cltbld', 16:45:42 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:42 INFO - '_': '/tools/buildbot/bin/python'} 16:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:45:42 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 16:45:42 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 16:45:42 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 16:45:42 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 16:45:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:45:44 INFO - Installing collected packages: mozsystemmonitor 16:45:44 INFO - Running setup.py install for mozsystemmonitor 16:45:44 INFO - Successfully installed mozsystemmonitor 16:45:44 INFO - Cleaning up... 16:45:45 INFO - Return code: 0 16:45:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:45:45 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')]} 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:45 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')]} 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:45 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:45 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 16:45:45 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 16:45:45 INFO - Using env: {'DISPLAY': ':0', 16:45:45 INFO - 'HOME': '/home/cltbld', 16:45:45 INFO - 'LANG': 'en_US.UTF-8', 16:45:45 INFO - 'LANGUAGE': 'en_US:en', 16:45:45 INFO - 'LOGNAME': 'cltbld', 16:45:45 INFO - 'MAIL': '/var/mail/cltbld', 16:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:45 INFO - 'MOZ_NO_REMOTE': '1', 16:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:45 INFO - 'NO_EM_RESTART': '1', 16:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:45 INFO - 'PWD': '/builds/slave/test', 16:45:45 INFO - 'SHELL': '/bin/bash', 16:45:45 INFO - 'SHLVL': '1', 16:45:45 INFO - 'TERM': 'linux', 16:45:45 INFO - 'TMOUT': '86400', 16:45:45 INFO - 'USER': 'cltbld', 16:45:45 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:45 INFO - '_': '/tools/buildbot/bin/python'} 16:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:45:45 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 16:45:45 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 16:45:45 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 16:45:45 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 16:45:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:45:46 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 16:45:46 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 16:45:46 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 16:45:46 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 16:45:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:46 INFO - warning: no files found matching '*.txt' 16:45:46 INFO - no previously-included directories found matching 'build' 16:45:46 INFO - no previously-included directories found matching 'dist' 16:45:46 INFO - no previously-included directories found matching '.git*' 16:45:46 INFO - Installing collected packages: jsonschema, functools32 16:45:46 INFO - Running setup.py install for functools32 16:45:46 INFO - warning: no files found matching '*.txt' 16:45:46 INFO - no previously-included directories found matching 'build' 16:45:46 INFO - no previously-included directories found matching 'dist' 16:45:46 INFO - no previously-included directories found matching '.git*' 16:45:46 INFO - Successfully installed jsonschema functools32 16:45:46 INFO - Cleaning up... 16:45:46 INFO - Return code: 0 16:45:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:45:46 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')]} 16:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:46 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')]} 16:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:46 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:46 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 16:45:46 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 16:45:46 INFO - Using env: {'DISPLAY': ':0', 16:45:46 INFO - 'HOME': '/home/cltbld', 16:45:46 INFO - 'LANG': 'en_US.UTF-8', 16:45:46 INFO - 'LANGUAGE': 'en_US:en', 16:45:46 INFO - 'LOGNAME': 'cltbld', 16:45:46 INFO - 'MAIL': '/var/mail/cltbld', 16:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:46 INFO - 'MOZ_NO_REMOTE': '1', 16:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:46 INFO - 'NO_EM_RESTART': '1', 16:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:46 INFO - 'PWD': '/builds/slave/test', 16:45:46 INFO - 'SHELL': '/bin/bash', 16:45:46 INFO - 'SHLVL': '1', 16:45:46 INFO - 'TERM': 'linux', 16:45:46 INFO - 'TMOUT': '86400', 16:45:46 INFO - 'USER': 'cltbld', 16:45:46 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:46 INFO - '_': '/tools/buildbot/bin/python'} 16:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:45:47 INFO - Cleaning up... 16:45:47 INFO - Return code: 0 16:45:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:47 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:47 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 16:45:47 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 16:45:47 INFO - Using env: {'DISPLAY': ':0', 16:45:47 INFO - 'HOME': '/home/cltbld', 16:45:47 INFO - 'LANG': 'en_US.UTF-8', 16:45:47 INFO - 'LANGUAGE': 'en_US:en', 16:45:47 INFO - 'LOGNAME': 'cltbld', 16:45:47 INFO - 'MAIL': '/var/mail/cltbld', 16:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:47 INFO - 'MOZ_NO_REMOTE': '1', 16:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:47 INFO - 'NO_EM_RESTART': '1', 16:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:47 INFO - 'PWD': '/builds/slave/test', 16:45:47 INFO - 'SHELL': '/bin/bash', 16:45:47 INFO - 'SHLVL': '1', 16:45:47 INFO - 'TERM': 'linux', 16:45:47 INFO - 'TMOUT': '86400', 16:45:47 INFO - 'USER': 'cltbld', 16:45:47 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:47 INFO - '_': '/tools/buildbot/bin/python'} 16:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:47 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 16:45:47 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 16:45:47 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 16:45:47 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 16:45:48 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 INFO - Downloading docopt-0.6.1.tar.gz 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:49 INFO - Running setup.py install for blobuploader 16:45:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:49 INFO - Running setup.py install for requests 16:45:49 INFO - Running setup.py install for docopt 16:45:49 INFO - Successfully installed blobuploader requests docopt 16:45:49 INFO - Cleaning up... 16:45:49 INFO - Return code: 0 16:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:49 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')]} 16:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:49 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')]} 16:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:49 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:49 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 16:45:49 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 16:45:49 INFO - Using env: {'DISPLAY': ':0', 16:45:49 INFO - 'HOME': '/home/cltbld', 16:45:49 INFO - 'LANG': 'en_US.UTF-8', 16:45:49 INFO - 'LANGUAGE': 'en_US:en', 16:45:49 INFO - 'LOGNAME': 'cltbld', 16:45:49 INFO - 'MAIL': '/var/mail/cltbld', 16:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:49 INFO - 'MOZ_NO_REMOTE': '1', 16:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:49 INFO - 'NO_EM_RESTART': '1', 16:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:49 INFO - 'PWD': '/builds/slave/test', 16:45:49 INFO - 'SHELL': '/bin/bash', 16:45:49 INFO - 'SHLVL': '1', 16:45:49 INFO - 'TERM': 'linux', 16:45:49 INFO - 'TMOUT': '86400', 16:45:49 INFO - 'USER': 'cltbld', 16:45:49 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:49 INFO - '_': '/tools/buildbot/bin/python'} 16:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:49 INFO - Running setup.py (path:/tmp/pip-Z2H_ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:49 INFO - Running setup.py (path:/tmp/pip-dzrYks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:50 INFO - Running setup.py (path:/tmp/pip-x7CA5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:50 INFO - Running setup.py (path:/tmp/pip-z4mibF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:50 INFO - Running setup.py (path:/tmp/pip-xh7tww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:50 INFO - Running setup.py (path:/tmp/pip-DJhPF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:50 INFO - Running setup.py (path:/tmp/pip-np3MSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:50 INFO - Running setup.py (path:/tmp/pip-zFxmWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:50 INFO - Running setup.py (path:/tmp/pip-woKsXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:50 INFO - Running setup.py (path:/tmp/pip-Qe97Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:50 INFO - Running setup.py (path:/tmp/pip-WYm74x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:50 INFO - Running setup.py (path:/tmp/pip-tLQRA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:50 INFO - Running setup.py (path:/tmp/pip-sCtrg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:50 INFO - Running setup.py (path:/tmp/pip-sETP6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:50 INFO - Running setup.py (path:/tmp/pip-T1hVq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:50 INFO - Running setup.py (path:/tmp/pip-uPpzgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:51 INFO - Running setup.py (path:/tmp/pip-7w8lpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:51 INFO - Running setup.py install for manifestparser 16:45:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozcrash 16:45:51 INFO - Running setup.py install for mozdebug 16:45:51 INFO - Running setup.py install for mozdevice 16:45:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozfile 16:45:51 INFO - Running setup.py install for mozhttpd 16:45:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozinfo 16:45:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozInstall 16:45:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozleak 16:45:51 INFO - Running setup.py install for mozlog 16:45:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Running setup.py install for moznetwork 16:45:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Running setup.py install for mozprocess 16:45:52 INFO - Running setup.py install for mozprofile 16:45:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Running setup.py install for mozrunner 16:45:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Running setup.py install for mozscreenshot 16:45:52 INFO - Running setup.py install for moztest 16:45:52 INFO - Running setup.py install for mozversion 16:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:52 INFO - Cleaning up... 16:45:52 INFO - Return code: 0 16:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45: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')]} 16:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:52 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:52 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 16:45:52 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 16:45:52 INFO - Using env: {'DISPLAY': ':0', 16:45:52 INFO - 'HOME': '/home/cltbld', 16:45:52 INFO - 'LANG': 'en_US.UTF-8', 16:45:52 INFO - 'LANGUAGE': 'en_US:en', 16:45:52 INFO - 'LOGNAME': 'cltbld', 16:45:52 INFO - 'MAIL': '/var/mail/cltbld', 16:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:52 INFO - 'MOZ_NO_REMOTE': '1', 16:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:52 INFO - 'NO_EM_RESTART': '1', 16:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:52 INFO - 'PWD': '/builds/slave/test', 16:45:52 INFO - 'SHELL': '/bin/bash', 16:45:52 INFO - 'SHLVL': '1', 16:45:52 INFO - 'TERM': 'linux', 16:45:52 INFO - 'TMOUT': '86400', 16:45:52 INFO - 'USER': 'cltbld', 16:45:52 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:52 INFO - '_': '/tools/buildbot/bin/python'} 16:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:53 INFO - Running setup.py (path:/tmp/pip-LpLZYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:53 INFO - Running setup.py (path:/tmp/pip-EhVYYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:53 INFO - Running setup.py (path:/tmp/pip-ZB3s6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:53 INFO - Running setup.py (path:/tmp/pip-a73nhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:53 INFO - Running setup.py (path:/tmp/pip-4p1h3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:53 INFO - Running setup.py (path:/tmp/pip-liRLrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:53 INFO - Running setup.py (path:/tmp/pip-bh3F6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:53 INFO - Running setup.py (path:/tmp/pip-0FXpoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:53 INFO - Running setup.py (path:/tmp/pip-2aKmBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:53 INFO - Running setup.py (path:/tmp/pip-_kcq4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:53 INFO - Running setup.py (path:/tmp/pip-kNpmC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:53 INFO - Running setup.py (path:/tmp/pip-EwkwvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:53 INFO - Running setup.py (path:/tmp/pip-Ofobs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:53 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)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:54 INFO - Running setup.py (path:/tmp/pip-NOmE8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:54 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)) 16:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:54 INFO - Running setup.py (path:/tmp/pip-Mmt_it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:54 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)) 16:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:54 INFO - Running setup.py (path:/tmp/pip-BdIJpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:54 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)) 16:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:54 INFO - Running setup.py (path:/tmp/pip-zyp20W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 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)) 16:45:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:54 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 16:45:54 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 16:45:54 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 16:45:54 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 16:45:55 INFO - Downloading blessings-1.6.tar.gz 16:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:55 INFO - Installing collected packages: blessings 16:45:55 INFO - Running setup.py install for blessings 16:45:55 INFO - Successfully installed blessings 16:45:55 INFO - Cleaning up... 16:45:55 INFO - Return code: 0 16:45:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:55 INFO - Reading from file tmpfile_stdout 16:45:55 INFO - Current package versions: 16:45:55 INFO - argparse == 1.2.1 16:45:55 INFO - blessings == 1.6 16:45:55 INFO - blobuploader == 1.2.4 16:45:55 INFO - docopt == 0.6.1 16:45:55 INFO - functools32 == 3.2.3-2 16:45:55 INFO - jsonschema == 2.5.1 16:45:55 INFO - manifestparser == 1.1 16:45:55 INFO - mozInstall == 1.13 16:45:55 INFO - mozcrash == 1.0 16:45:55 INFO - mozdebug == 0.1 16:45:55 INFO - mozdevice == 0.51 16:45:55 INFO - mozfile == 1.2 16:45:55 INFO - mozhttpd == 0.7 16:45:55 INFO - mozinfo == 0.10 16:45:55 INFO - mozleak == 0.1 16:45:55 INFO - mozlog == 3.5 16:45:55 INFO - moznetwork == 0.27 16:45:55 INFO - mozprocess == 0.25 16:45:55 INFO - mozprofile == 0.28 16:45:55 INFO - mozrunner == 6.13 16:45:55 INFO - mozscreenshot == 0.1 16:45:55 INFO - mozsystemmonitor == 0.3 16:45:55 INFO - moztest == 0.8 16:45:55 INFO - mozversion == 1.4 16:45:55 INFO - psutil == 3.1.1 16:45:55 INFO - requests == 1.2.3 16:45:55 INFO - wsgiref == 0.1.2 16:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:55 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 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:55 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 16:45:55 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 16:45:55 INFO - Using env: {'DISPLAY': ':0', 16:45:55 INFO - 'HOME': '/home/cltbld', 16:45:55 INFO - 'LANG': 'en_US.UTF-8', 16:45:55 INFO - 'LANGUAGE': 'en_US:en', 16:45:55 INFO - 'LOGNAME': 'cltbld', 16:45:55 INFO - 'MAIL': '/var/mail/cltbld', 16:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:55 INFO - 'MOZ_NO_REMOTE': '1', 16:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:55 INFO - 'NO_EM_RESTART': '1', 16:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:55 INFO - 'PWD': '/builds/slave/test', 16:45:55 INFO - 'SHELL': '/bin/bash', 16:45:55 INFO - 'SHLVL': '1', 16:45:55 INFO - 'TERM': 'linux', 16:45:55 INFO - 'TMOUT': '86400', 16:45:55 INFO - 'USER': 'cltbld', 16:45:55 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:55 INFO - '_': '/tools/buildbot/bin/python'} 16:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 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)) 16:45:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:45:57 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)) 16:45:57 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)) 16:45:57 INFO - Installing collected packages: simplejson 16:45:57 INFO - Running setup.py install for simplejson 16:45:57 INFO - building 'simplejson._speedups' extension 16:45:57 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 16:45:58 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 16:45:58 INFO - Successfully installed simplejson 16:45:58 INFO - Cleaning up... 16:45:58 INFO - Return code: 0 16:45:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17539c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', '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 16:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:45:58 INFO - Using env: {'DISPLAY': ':0', 16:45:58 INFO - 'HOME': '/home/cltbld', 16:45:58 INFO - 'LANG': 'en_US.UTF-8', 16:45:58 INFO - 'LANGUAGE': 'en_US:en', 16:45:58 INFO - 'LOGNAME': 'cltbld', 16:45:58 INFO - 'MAIL': '/var/mail/cltbld', 16:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:58 INFO - 'MOZ_NO_REMOTE': '1', 16:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:58 INFO - 'NO_EM_RESTART': '1', 16:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:58 INFO - 'PWD': '/builds/slave/test', 16:45:58 INFO - 'SHELL': '/bin/bash', 16:45:58 INFO - 'SHLVL': '1', 16:45:58 INFO - 'TERM': 'linux', 16:45:58 INFO - 'TMOUT': '86400', 16:45:58 INFO - 'USER': 'cltbld', 16:45:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:58 INFO - '_': '/tools/buildbot/bin/python'} 16:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:45:58 INFO - Cleaning up... 16:45:58 INFO - Return code: 0 16:45:58 INFO - Running post-action listener: _resource_record_post_action 16:45:58 INFO - Running post-action listener: _start_resource_monitoring 16:45:58 INFO - Starting resource monitoring. 16:45:58 INFO - [mozharness: 2017-09-27 23:45:58.529421Z] Finished create-virtualenv step (success) 16:45:58 INFO - [mozharness: 2017-09-27 23:45:58.529896Z] Running install step. 16:45:58 INFO - Running pre-action listener: _resource_record_pre_action 16:45:58 INFO - Running main action method: install 16:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:58 INFO - Reading from file tmpfile_stdout 16:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:58 INFO - Reading from file tmpfile_stdout 16:45:58 INFO - Output received: 16:45:58 INFO - Usage: mozinstall [options] installer 16:45:58 INFO - Options: 16:45:58 INFO - -h, --help show this help message and exit 16:45:58 INFO - -d DEST, --destination=DEST 16:45:58 INFO - Directory to install application into. [default: 16:45:58 INFO - "/builds/slave/test"] 16:45:58 INFO - --app=APP Application being installed. [default: firefox] 16:45:58 INFO - mkdir: /builds/slave/test/build/application 16:45:58 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'] 16:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:46:16 INFO - Reading from file tmpfile_stdout 16:46:16 INFO - Output received: 16:46:16 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:16 INFO - Running post-action listener: _resource_record_post_action 16:46:16 INFO - [mozharness: 2017-09-27 23:46:16.723303Z] Finished install step (success) 16:46:16 INFO - [mozharness: 2017-09-27 23:46:16.723556Z] Running setup-mitmproxy step. 16:46:16 INFO - Running pre-action listener: _resource_record_pre_action 16:46:16 INFO - Running main action method: setup_mitmproxy 16:46:16 INFO - Skipping: mitmproxy is not required 16:46:16 INFO - Running post-action listener: _resource_record_post_action 16:46:16 INFO - [mozharness: 2017-09-27 23:46:16.724689Z] Finished setup-mitmproxy step (success) 16:46:16 INFO - [mozharness: 2017-09-27 23:46:16.724910Z] Running run-tests step. 16:46:16 INFO - Running pre-action listener: _resource_record_pre_action 16:46:16 INFO - Running pre-action listener: _set_gcov_prefix 16:46:16 INFO - Running main action method: run_tests 16:46:16 WARNING - Try message not found. 16:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:16 INFO - Python 2.7.3 16:46:16 INFO - Return code: 0 16:46:16 INFO - grabbing minidump binary from tooltool 16:46:16 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')]} 16:46:16 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 0x1750d60>, '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 0x1751a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:16 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 16:46:16 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 16:46:16 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 16:46:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:16 INFO - Return code: 0 16:46:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:16 INFO - ENV: RUST_BACKTRACE is now full 16:46:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:16 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/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:46:16 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/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:46:16 INFO - Using env: {'DISPLAY': ':0', 16:46:16 INFO - 'HOME': '/home/cltbld', 16:46:16 INFO - 'LANG': 'en_US.UTF-8', 16:46:16 INFO - 'LANGUAGE': 'en_US:en', 16:46:16 INFO - 'LOGNAME': 'cltbld', 16:46:16 INFO - 'MAIL': '/var/mail/cltbld', 16:46:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:16 INFO - 'MOZ_ACCELERATED': '1', 16:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:16 INFO - 'MOZ_NO_REMOTE': '1', 16:46:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:16 INFO - 'MOZ_WEBRENDER': '1', 16:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:16 INFO - 'NO_EM_RESTART': '1', 16:46:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:16 INFO - 'PWD': '/builds/slave/test', 16:46:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:16 INFO - 'RUST_BACKTRACE': 'full', 16:46:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:46:16 INFO - 'SHELL': '/bin/bash', 16:46:16 INFO - 'SHLVL': '1', 16:46:16 INFO - 'TERM': 'linux', 16:46:16 INFO - 'TMOUT': '86400', 16:46:16 INFO - 'USER': 'cltbld', 16:46:16 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:16 INFO - '_': '/tools/buildbot/bin/python'} 16:46:16 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/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:46:17 INFO - mozversion application_buildid: 20170927215532 16:46:17 INFO - mozversion application_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 16:46:17 INFO - mozversion application_display_name: Nightly 16:46:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:17 INFO - mozversion application_name: Firefox 16:46:17 INFO - mozversion application_remotingname: firefox 16:46:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:46:17 INFO - mozversion application_vendor: Mozilla 16:46:17 INFO - mozversion application_version: 58.0a1 16:46:17 INFO - mozversion platform_buildid: 20170927215532 16:46:17 INFO - mozversion platform_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 16:46:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:46:17 INFO - mozversion platform_version: 58.0a1 16:46:17 INFO - using testdate: 1506555977 16:46:17 INFO - actual date: 1506555977 16:46:17 INFO - starting webserver on 'localhost:54553' 16:46:17 INFO - SUITE-START | Running 2 tests 16:46:17 INFO - TEST-START | dromaeo_css 16:46:17 INFO - Initialising browser for dromaeo_css test... 16:46:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54553/getInfo.html -profile /tmp/tmp559OpI/profile 16:46:17 INFO - TEST-INFO | started process 15300 (/builds/slave/test/build/application/firefox/firefox http://localhost:54553/getInfo.html) 16:46:25 INFO - TEST-INFO | 15300: exit 0 16:46:25 INFO - Browser initialized. 16:46:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:25 INFO - Using env: {'DISPLAY': ':0', 16:46:25 INFO - 'HOME': '/home/cltbld', 16:46:25 INFO - 'JSGC_DISABLE_POISONING': '1', 16:46:25 INFO - 'LANG': 'en_US.UTF-8', 16:46:25 INFO - 'LANGUAGE': 'en_US:en', 16:46:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:46:25 INFO - 'LOGNAME': 'cltbld', 16:46:25 INFO - 'MAIL': '/var/mail/cltbld', 16:46:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:25 INFO - 'MOZ_ACCELERATED': '1', 16:46:25 INFO - 'MOZ_CRASHREPORTER': '1', 16:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:46:25 INFO - 'MOZ_NO_REMOTE': '1', 16:46:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:25 INFO - 'MOZ_WEBRENDER': '1', 16:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:25 INFO - 'NO_EM_RESTART': '1', 16:46:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:25 INFO - 'PWD': '/builds/slave/test', 16:46:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:25 INFO - 'RUST_BACKTRACE': 'full', 16:46:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:46:25 INFO - 'SHELL': '/bin/bash', 16:46:25 INFO - 'SHLVL': '1', 16:46:25 INFO - 'TERM': 'linux', 16:46:25 INFO - 'TMOUT': '86400', 16:46:25 INFO - 'USER': 'cltbld', 16:46:25 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 16:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:25 INFO - '_': '/tools/buildbot/bin/python'} 16:46:25 INFO - TEST-INFO | started process 15545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp559OpI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:26 INFO - PID 15545 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:46:26 INFO - PID 15545 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:46:26 INFO - PID 15545 | 16:46:26 INFO - PID 15545 | (/builds/slave/test/build/application/firefox/firefox:15605): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:46:26 INFO - PID 15545 | 16:46:37 INFO - PID 15545 | RSS: Main: 205475840 16:46:37 INFO - PID 15545 | 16:49:34 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54553/tests/dromaeo/cssquery-ext.html) 16:49:36 INFO - PID 15545 | RSS: Main: 203882496 16:49:36 INFO - PID 15545 | 16:52:39 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-ext.html (next: http://localhost:54553/tests/dromaeo/cssquery-jquery.html) 16:52:39 INFO - PID 15545 | RSS: Main: 202276864 16:52:39 INFO - PID 15545 | 16:55:41 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54553/tests/dromaeo/cssquery-mootools.html) 16:55:42 INFO - PID 15545 | RSS: Main: 204582912 16:55:42 INFO - PID 15545 | 16:58:44 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54553/tests/dromaeo/cssquery-prototype.html) 16:58:45 INFO - PID 15545 | RSS: Main: 204013568 16:58:45 INFO - PID 15545 | 17:01:48 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54553/tests/dromaeo/cssquery-yui.html) 17:01:49 INFO - PID 15545 | RSS: Main: 206626816 17:01:49 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-yui.html (next: http://localhost:54553/tests/dromaeo/cssquery-dojo.html) 17:04:51 INFO - PID 15545 | RSS: Main: 207138816 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | __start_tp_report 17:04:51 INFO - PID 15545 | _x_x_mozilla_page_load 17:04:51 INFO - PID 15545 | _x_x_mozilla_page_load_details 17:04:51 INFO - PID 15545 | |i|pagename|runs| 17:04:51 INFO - PID 15545 | |0;dojo.html;3193.792403493773;3235.838208089596;3236.6763323667637;3289.588801399825;3294.5552350432686;6217.409346112124;6289.371062893714;6317.810465686037;6336.809895703131;6377.04344348348;6236.968815155918;6329.208848893888;6338.841528961778;6348.936510634892;6359.71381287842;5765.596408251424;5800.390958949291;5835.44563266489;5838.854028649275;5898.7640494380175;5829.999999999979;5886.970565147169;5888.440598143169;5910.527157827363;5993.490553302974;5871.500922421599;5886.352501224862;5942.7920022799;5960.79137230197;5989.610675306113;5664.433556644302;5734.111212762028;5771.797987070432;5868.823935281948;5892.616979896293;5771.769129234825;5784.768609255625;5854.736536855852;5875.441833025856;5903.557233207526;6203.658798766066;6310.8106756796915;6360.618362898241;6389.872202555923;6415.935840641627;6739.5619284746335;6820.965895170542;6842.794716158523;6857.451403887677;6877;6874.759383421606;6876.553024053471;6904.551204171713;6914.412274956584;6924.376806087426;6242.344553821874;6290.528210384239;6309.337519560426;6369.904451433186;6393.232812062536;6884.586924784529;6923.238443771181;6950.443964482829;6967.303269672992;7008;6586.077949087132;6648.235452922879;6650.20197576294;6691.431228345547;6695.665216739144;6781.186257649114;6790.796276111724;6804.081449004321;6813.863722725518;6815.182178138655;6620.404163625297;6850.109485766819;6855.5543889647015;6857.897131543031;6870.656467176621;6773.62745049027;6777.2545020047755;6795.7961261162245;6899.655017249117;6938.722451102;4927.063857866994;4966.925496117489;4993.425756038102;5009.524095210949;5061.8357777711335;4395.626371758436;4428.22506061438;4438.778061096932;4462.107578484316;4484.192845287815;5849.678267695318;5875.118732190205;5886.735096920564;5888.116782482662;5921.319048309413;6861.142357205349;6876.312368763083;6942.479314051467;6964.825879353057;6977.1278590176225;5645.576581756302;5801.332846722681;5826.82519524415;5830.650160990354;5832.650040997553;5857.736401861841;5888.234529511136;5897.616654917502;5903.498202652737;5921.378255283219;6614.10709554204;6670.4997125215805;6701.262861085277;6701.899471507932;6714.429273511709;6870.27862074495;6870.931290687029;6929.965350173217;6949.583025018616;6993.965030174817;6418.133551970611;6577.177852768404;6624.6025238485845;6720.697568609522;6721.899171512529;6621.1392518972225;6646.734130634721;6649.434798042221;6660.2673705893285;6687.665616719242;6664.966675166593;6717.1267735194115;6782;6789.728410863708;6797.72809087631;6613.867722645424;6638.302978187414;6652.2349929756765;6664.133662623828;6682.264950855305;6589.967050164719;6614.470842332698;6671.499637527108;6687.03038059469;6693.431058360094;6428.485721142204;6489.5781774184525;6546.639934803441;6653.367930046637;6669.09967154428;6609.074729537772;6640;6662.100616416722;6672.032555279555;6686.197656281277;6381.3937675920715;6388.265349484869;6393.232812062396;6446.709898054505;6460.515461340512 17:04:51 INFO - PID 15545 | |1;ext.html;837.7863644770583;855.3542075732821;858.5664239559023;862.4264863865534;862.7454900804262;37846;38470.038249043755;40621.187576248456;40863.38704919425;41058.17883642333;37730.62269377305;38004.61995380045;38008.239835203276;38125.618743812556;38308;7104.7513337033215;7236.421086313108;7249.093863267091;7257.637118144072;7262.419006479469;7115.7153713851385;7122;7193.42452603793;7196.604186769726;7197.3882220011365;7124.394426473756;7134.7859564212895;7197.8920316195035;7200.675969581382;7232.674529646152;7104.928950710479;7763.0684317882215;8004.159563245892;8006.879896801553;8068.798280043045;7986.800329991796;8056.556889371082;8060.153683863168;8072.596370181526;8091.757247282591;36307.4553881692;36449.453258201145;36549.63450365516;37065.814670926746;37096.629033709854;3513.508108864761;3567.7859328440377;3577.0878426001464;3589.246258285763;3589.4795254688183;31743.52384714231;31990.840045799854;32118.518222226685;32288.354232915444;32357.83821080903;4538.2738761797955;4543.727376357396;4638.698484598524;4649.395578574798;4675.2052151134385;175987;176124;176854;177415.11292443585;178790.10604946892;40301.99999999941;41659.58340416557;47051.52948470471;47248.76375618169;47372;48414.5158548417;48681;48805.75597122063;48893.51106488961;49283.50716492789;14800.703985920221;14914.776278355834;14973.401063957537;15028.474003409829;15059.096454212782;12000.519979200733;12021.338826364634;12042.81935770964;12053.819192712117;12062.87937120635;13236.801447978289;13250.668733281746;13360.866391335961;13412.865871341357;13657.658558536115;5451.890962180734;5560.833175004756;5609.80365687199;5614.101743720985;5661;1004.7940172264668;1012.9493525323852;1023.1967905194387;1030.5414090729703;1035.140833108518;22248.77751222467;22710.52381595191;22806.42983925382;22957.426064348525;23188.65217021746;1114.3171817144416;1126.5550107707575;1131.671815173607;1134.472470301314;1139.0887290167832;12183;12275.263484190977;12335.6916077097;12389.814152787716;12391.690207744698;219935;220046.79953200583;220703;222294;222584;49529.50470495249;49604;49666.50333496619;49766;49783.751081244365;1410.5627255550812;1437.8798008321967;1469.897107202507;1472.6244807574;1480.8815294776177;22322.553548929256;22512.887435563374;22558.77441225567;22848.31455056351;22873.31380058601;35951.64048359483;35996.28007439889;36000.27999439944;36007.45988810118;36165.45751813777;170432;171180;171726.14136929237;172675;173482;28614.284642884093;29396;32254.83872580622;32820.67179328176;32854.67145328516;40811.38782918318;41159.38260926028;41250.79374603108;41289.380659290735;42405.787971059945;30115.69884301129;30733;30923.845380772953;31001.37997240088;31353.216169595944;30099;30114.397712046073;30472.238194045327;30824.537631935986;31216.375672486876;34113.658863411045;34230.31539369149;34429;34826.12934676653;35019.47470787991;29769.851150744107;29990.85004574963;30433;30940;31498.527522087647;22857;23231.186908458123;23305.766942331036;23327.300180994596;23596.528069438173 17:04:51 INFO - PID 15545 | |2;jquery.html;570.1362435909598;574.8993926062943;575.6574837971408;589.2281111743615;602.5029350785602;20741.170353185855;21349.786502134975;21510.56978860424;21688.783112168872;21705.891470542665;23073.077076916903;23318;23367.883160584217;23434.64848027277;24175;6484.773032943848;6675.232348279961;6676;6680.699368528428;6703;6571.474282057424;6677;6687.966560167217;6690.7323707051655;6692.93307066928;6077.7568897244055;6607;6640.900386494206;6655.567388119756;6663.566868153554;6208.78269260576;6276.435120839124;6326.715297811586;6335.8416039598915;6350.237971443456;5901.881962360729;5906.409359064102;5918.3785702501045;5921.763129474816;5928.258967629046;27416;27594.310142246402;28269.15192544227;28368.156069855395;28516;1978.1691689490306;2027.6552985992269;2041.6529190037581;2044.396902913644;2048.5800410915726;19307.4207773767;19508.414747557596;19630.901845490826;19636.70544941827;19684.212631494724;2325.1396983116188;2346.554154710617;2366.491204391064;2370.8577485350934;2458.704955405363;118989;123535.3823230878;127125;133306.33346833204;134764.32617836847;14707.823374130045;14707.926460367844;14714.55856324312;14808.037477563925;14955.325910971827;23293.883530582578;23428.18001369944;23572.88213558921;23584.882075589856;23625.40936476602;9122.86315705265;9249.583768730423;9259.629614815467;9320.953395233117;9344.719658410258;8088.191180881982;8236.546989915612;8269.875951860728;8310.21052999964;8386.454880432751;8836.293096552261;9015.729528114167;9082.636694532144;9115.544222788834;9124.58939347731;2568.948621027569;2587.1721049264056;2705.7294270572784;2739.8080637192807;2848.6154369160313;954.7660823098386;959.6451798961776;967.5645959318335;969.1277849935115;970.2238209432426;19088.61822763565;19199.040047997543;19308.4207473776;19535.218591256475;19739.901300493406;985.1281615770096;1003.5484032185545;1005.3766664667953;1009.833642143311;1016.5222345497605;10436.37381757097;10794.190435717353;10834.837477437844;10905.291156074829;10906.236563440641;430729;449041;459452;467249;471638;105419;107652.46173769081;108367;110919.44540277247;111335;1028.573142146016;1117.8379135025375;1147.9827802582968;1163.1334655681571;1164.2083383299268;20086;20282;20695.482612934797;20720.067596958474;21005.36983890486;53057.20414193713;54419;54477;55100;56967;65781.67109164424;68348.3165168342;68876.65561672159;69369;69760;14404.495842645458;14542.127472351693;14545.490907818175;14653.12081275127;14681.92659036698;22247.666285005413;22387.552248955257;22557.548849023256;22637.094516219167;23028.53942921099;17683.73474397859;17797.644047118727;17820.732689009936;18132;18382.632347353247;16424.67150657004;16730.49808505698;16746.4138755143;16766.832331677015;17076.487705368858;18188.636227275114;18647.254109835998;18768.53078673044;18792.812071879107;18795.154218060492;14277.357518911882;14585.92707036458;14618.926905365404;14881.776773348625;15065.397384104514;18045.458636240935;18277.817221827612;18441.81558184401;18651.347202847835;18687.345942892476 17:04:51 INFO - PID 15545 | |3;mootools.html;1312.744014917091;1404.192589261175;1405.9015868889182;1410.1116296733057;1438.798568200452;14778.704425911488;15475.922620386911;15499.922500387496;15506;15536.922315388421;15087.01934374265;15098.773518397205;15311.617209569766;15434.305456254468;15442.459513917016;2694.6362241097495;2719.1978366381913;2769.7507224349806;2770.0720258713354;2771.9584206236923;2528.3552694062987;2537.099329737944;2539.21284401836;2541.4789968056502;2543.4023004593996;2547.426828963487;2617.084020592796;2632.7104018557943;2633.3943193065606;2647.4969755746442;2563.5513785087537;2661.8935242590273;2698.17705599792;2723.2783312422225;2723.305557082951;2556.335352808265;2593.714691383946;2633.710291867893;2635.235781623327;2645.2196602002455;14690.265486725728;15021.549353519302;15045.322960466805;15047.548573542812;15055.849441505554;7740.303372696428;7990.280874721245;7993.240642138988;8015.238552337577;8027.598620068973;4873.707577545323;5307.787688492455;5445;5480.945190548123;5538.778448862041;1803.386848471526;1870;1880.8683392162554;1896.2888916656254;1935.4967708395918;24213.152539661205;25211.495770084497;25266.36834079163;26277.73722262772;26955.46089078227;7068.3285087916565;7081;7089.184743754431;7337.88993165103;7366.742164024341;20268.594628107356;20428.387148385573;20430;20449.795502044788;20514.589708205753;8015.719449819228;8074.232947869943;8095.797605059921;8128.512289262545;8150.877736833952;7155.141383034069;7226.241244669339;7429.591372474566;7438.5536867788105;7516.699332026657;5471.671699698031;5597.188407680945;5662.971685141631;5713.685747283939;5758.654480731169;1674.3051633571931;1679.420599893035;1679.8908070975347;1700.1839117223801;1728.4209789720333;907.2696479334068;922.6447817590276;923.3536524432924;931.4690626343055;933.5472295936465;7729.768106956801;7775.339096176888;7795.259450352208;7934.206579342135;7954.761357159295;696.6551556979327;703.9366457018892;705.4497491956282;707.6956908529381;717.1645033535872;4734.786934587952;4744.932390212175;4753.191957367256;4803.615710743132;4826.420829500483;20680.689789653166;21606;21632.567348652938;21787.346379608636;21933.561328773336;20787.06458209384;21076.894615526824;21311.36065918025;21500.354989350344;21573.244936427465;11296.717582060513;11666.183367164387;11674.066074714003;11687.415629218505;11827.645170644895;8075.959620202097;8129.715459958873;8231.300339470972;8234.135415781257;8283.710070147516;17685.292588296837;18596.44210673682;18858.30275275232;19170.329038483585;19258.037098144756;18375.173117210026;19055.618887622448;19065.996140810585;19780.802191977895;19953.501162471053;12424.06819488524;12429.875701242872;12482.75034499323;12499.125061245626;12514.43685034194;14006.299685015912;14012.509562165274;14116.223607701675;14347.282635867956;14392.85607143957;11602.361870097226;11928;11972.341521216069;11978.64064078079;12009.279443233434;11644.592439264585;11675.35785531804;11687.532498699957;11688.649340519798;11737.413129343327;9588.185004274435;9663.323567350499;9805.558749856416;9884.654037108667;9903.306768526421;6604.306547812603;6604.900926486011;6625.966870165811;6709.664516774044;6749.73001079971;6714.9328506716265;6852.623105729033;6894.517383783087;6911.239763626098;7057.470689698191 17:04:51 INFO - PID 15545 | |4;prototype.html;517.8161752577835;517.8342930262318;533.0257165019192;535.9624826262163;542.5036091975842;6153.661548614825;6153.8461538461515;6182.134501169834;6229.781957631484;6238.968805155979;6097.146399504073;6117.480014198787;6119.602225855317;6154.599951003182;6162.815115546541;5085.593152547805;5088.694678319294;5101.617378696594;5116.70197034491;5123.692578445287;5067.111746304608;5089.491050894918;5101.38783345999;5108.438071812097;5148.897022059557;4808.735519546423;4898.118338699032;4899.118158731427;4899.657024008303;4906.582940450066;4874.951250487521;4880.24356224784;4897.094037603055;4926.950730492685;4938.432080310774;4384.145091707119;4399.318105693623;4405.163019026407;4467.5755803198645;4483.977580112111;5898.528117750569;5908.468237858613;5923.289205295392;5942.227510423617;5970.641761494324;5604.887902241932;5651.378348381675;5677.120046392815;5708.4862362387585;5715.199872017921;6350.745970161188;6372.426481616677;6384.648844313561;6444.484441244689;6463.7737679181;4627.838025669119;4723.527647235283;4781.42622885256;4820.228763397875;4833.516648335173;6495.928171851639;6584.9012264816065;6598.637074960923;6636.668166591651;6708.597484151015;4899.216125419915;4904.166291730415;4933.186024305949;4939.3084968104495;4981.153203955337;5003.399592048904;5005.174146265826;5015;5038.042771873333;5062.670926389773;5566;5584.972075139598;5588.3573389060775;5618.719064046782;5646.4353564644025;6272.780452684226;6408.935910640927;6511.609303441809;6548.6725663716625;6563.606183628997;1719.819418961016;1745.1187150489175;1748.9825101749075;1756.1043867627602;1768.4959786461054;1165.1727273635645;1221.7922953097996;1229.1457437081322;1239.9380030998595;1251.205484517338;5550.306211723535;5604;5627.268455100892;5658.321001479849;5670.319561652628;6567.704453299613;6572.572782769104;6601.547659514899;6671.39957403836;6678.33216678338;5501.697406642673;5573.359063707644;5582.804601838998;5602.887942241214;5699.316082070095;3401.8809341672923;3408.608010078823;3425.4348032574344;3450.413429716954;3496.07715756333;6259.874802503924;6267.435930766253;6286.622802631857;6317.873642527215;6417.133686952295;6207.020630097579;6590.406863382319;6694.054615969056;6737.764178253738;6772.8984065239065;6246.9062964054665;6280.340564240689;6296.496280297565;6299.496040316855;6404.48764098871;6382.9999900046905;6399.84802735512;6442.935570644421;6537.607743535403;6577.934220657732;6321.936780632135;6385.616862988049;6433.099366088658;6463.967680161569;6467.514936379696;6277.91935242078;6289.182406287154;6306.342321453638;6310.286576772032;6324.300284333716;4783.976080119577;4886.82716148129;4907.478681608713;4929.950700493093;4988.201887697951;6317.96841015792;6499.610023398611;6557.770478033246;6561.540692151503;6660.167479065117;6227.377262273736;6331.873362532816;6359.904601431075;6463;6501.4798816095545;6337.461315788025;6371.331010244043;6403.3596640337455;6454.935450645434;6465;6310.716017779303;6335.176427064452;6340.270868850142;6362.650054246876;6387.361263873576;6356.5232607555545;6396.936030639634;6438.517111216771;6460.870782584416;6465.676716164267;6170.197874276315;6200.054973887368;6222.471089957405;6295.811125666238;6304.5271604628915 17:04:51 INFO - PID 15545 | |5;yui.html;891.313688459886;891.7592250092474;904.5838914099514;907.0883761819371;908.7864351877307;19621.31325403611;19995.20019199234;20069.99999999998;20094.69857952132;20159.19363225471;18147.81852181481;18315.358962436316;18354;18414.26342946284;18563.628727425443;960.6733710538398;975.5756246032963;978.7602037500823;985.0641890204299;991.5934466868586;974.9512524373788;976.5947131940236;979.5151400056982;983.0317137619439;985.2905907746447;988.2489308125804;1013.5185786751271;1028.5680014393936;1037.7094413564214;1041.0214398465419;995.1740055753743;1001.8246806808852;1005.3917379985113;1008.4403156248279;1013.2248829645328;723.4284914917209;725.8947452619393;725.961874519437;732.0922056649716;733.2740586819064;19196.13617387207;19616.60766784656;19735.703964440545;19941.700874486894;20379.18483260668;21195.576088478298;21235.68146477804;21648;21672.34982950514;21697.891510542504;16446.342146314135;16615.169241537995;16792.160391980353;16797.160141992852;16858.747118793228;3629.2922880038404;3634.5638523377365;3642.1440961374055;3647.270545890806;3650.361186792301;102383.48808255911;105426.47286763517;134736;137764;141595.29202354024;13595.252261125535;14008.579742607739;14109.223992680501;14111.929440352938;14144.29278536069;30106.397872042435;30405.39189216203;30945.226369340497;31018.224544386572;31167.68832311648;9194.586243619053;9223.815523689489;9244.029376915327;9251.861222081674;9277.396969197116;4250.426192463978;4342.174986752507;4405.84579539721;4408.823647054082;4427.911441771146;5337.092694241988;5380.650257733235;5409.26974858397;5430.8913821723345;5454.7818087276855;987.0770829274651;995.1789773436799;1018.4958445569342;1019.3934608907688;1022.412113034993;670.1890712238246;679.5956405938458;685.8833998220215;694.572837704818;700.8948657701284;12139.332336721565;12219.938900305442;12361.752764944831;12615.432305546272;12987.220766754024;692.1901375390805;695.8016965164903;702.5538782872912;717.3866344275674;718.1489934427719;5674.404187560329;5700.686462244616;5707.429257074259;5841.561882858802;5855.560832937546;114316;116724;117447;117903.41048294703;121517;97274.51362743283;98793.50603247082;100798.49600752095;101824;102767;81383;85873.57063214644;86951;87154;89625;10290.794184116425;10353.9482302588;10706.143508519455;10721.571137154739;10808.729781755519;42791.144177116905;43511;43673;43900.341494876964;44013.33979990239;53629.7318513405;55460.72269638626;55557.44442555523;55557.722211390304;56315;14682.55952321432;14791.92604036973;14843.777343339643;14870.925645371704;15004.474843380429;17726.290948361922;17778.199981000627;17928.372506962194;17946.461606151835;18095.36666216676;15296.464623738117;15358.155301458528;15579.76630350523;15605.141717205663;15689.293981771076;14524.85475145235;14686.853131468975;14702.55892323232;14799.260036998323;14887.702245954804;15425.382984680487;15456.459023934558;15654.13902235388;15757.921210393875;15959.680806383574;10251.84622230682;10404.323718958243;10458.477076146315;10560.155187584822;10617.522211500656;10844.295120817122;10904.34573925567;10927;10969.341839489656;11080.501377437873 17:04:51 INFO - PID 15545 | __end_tp_report 17:04:51 INFO - PID 15545 | __start_cc_report 17:04:51 INFO - PID 15545 | _x_x_mozilla_cycle_collect,268 17:04:51 INFO - PID 15545 | __end_cc_report 17:04:51 INFO - PID 15545 | __startTimestamp1506557091836__endTimestamp 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | ------- Summary: start ------- 17:04:51 INFO - PID 15545 | Number of tests: 6 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#0] dojo.html Cycles:165 Average:6244.48 Median:6489.58 stddev:777.68 (12.0%) stddev-sans-first:742.33 17:04:51 INFO - PID 15545 | Values: 3193.8 3235.8 3236.7 3289.6 3294.6 6217.4 6289.4 6317.8 6336.8 6377.0 6237.0 6329.2 6338.8 6348.9 6359.7 5765.6 5800.4 5835.4 5838.9 5898.8 5830.0 5887.0 5888.4 5910.5 5993.5 5871.5 5886.4 5942.8 5960.8 5989.6 5664.4 5734.1 5771.8 5868.8 5892.6 5771.8 5784.8 5854.7 5875.4 5903.6 6203.7 6310.8 6360.6 6389.9 6415.9 6739.6 6821.0 6842.8 6857.5 6877.0 6874.8 6876.6 6904.6 6914.4 6924.4 6242.3 6290.5 6309.3 6369.9 6393.2 6884.6 6923.2 6950.4 6967.3 7008.0 6586.1 6648.2 6650.2 6691.4 6695.7 6781.2 6790.8 6804.1 6813.9 6815.2 6620.4 6850.1 6855.6 6857.9 6870.7 6773.6 6777.3 6795.8 6899.7 6938.7 4927.1 4966.9 4993.4 5009.5 5061.8 4395.6 4428.2 4438.8 4462.1 4484.2 5849.7 5875.1 5886.7 5888.1 5921.3 6861.1 6876.3 6942.5 6964.8 6977.1 5645.6 5801.3 5826.8 5830.7 5832.7 5857.7 5888.2 5897.6 5903.5 5921.4 6614.1 6670.5 6701.3 6701.9 6714.4 6870.3 6870.9 6930.0 6949.6 6994.0 6418.1 6577.2 6624.6 6720.7 6721.9 6621.1 6646.7 6649.4 6660.3 6687.7 6665.0 6717.1 6782.0 6789.7 6797.7 6613.9 6638.3 6652.2 6664.1 6682.3 6590.0 6614.5 6671.5 6687.0 6693.4 6428.5 6489.6 6546.6 6653.4 6669.1 6609.1 6640.0 6662.1 6672.0 6686.2 6381.4 6388.3 6393.2 6446.7 6460.5 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#1] ext.html Cycles:180 Average:35329.43 Median:34171.99 stddev:49504.52 (144.9%) stddev-sans-first:49575.65 17:04:51 INFO - PID 15545 | Values: 837.8 855.4 858.6 862.4 862.7 37846.0 38470.0 40621.2 40863.4 41058.2 37730.6 38004.6 38008.2 38125.6 38308.0 7104.8 7236.4 7249.1 7257.6 7262.4 7115.7 7122.0 7193.4 7196.6 7197.4 7124.4 7134.8 7197.9 7200.7 7232.7 7104.9 7763.1 8004.2 8006.9 8068.8 7986.8 8056.6 8060.2 8072.6 8091.8 36307.5 36449.5 36549.6 37065.8 37096.6 3513.5 3567.8 3577.1 3589.2 3589.5 31743.5 31990.8 32118.5 32288.4 32357.8 4538.3 4543.7 4638.7 4649.4 4675.2 175987.0 176124.0 176854.0 177415.1 178790.1 40302.0 41659.6 47051.5 47248.8 47372.0 48414.5 48681.0 48805.8 48893.5 49283.5 14800.7 14914.8 14973.4 15028.5 15059.1 12000.5 12021.3 12042.8 12053.8 12062.9 13236.8 13250.7 13360.9 13412.9 13657.7 5451.9 5560.8 5609.8 5614.1 5661.0 1004.8 1012.9 1023.2 1030.5 1035.1 22248.8 22710.5 22806.4 22957.4 23188.7 1114.3 1126.6 1131.7 1134.5 1139.1 12183.0 12275.3 12335.7 12389.8 12391.7 219935.0 220046.8 220703.0 222294.0 222584.0 49529.5 49604.0 49666.5 49766.0 49783.8 1410.6 1437.9 1469.9 1472.6 1480.9 22322.6 22512.9 22558.8 22848.3 22873.3 35951.6 35996.3 36000.3 36007.5 36165.5 170432.0 171180.0 171726.1 172675.0 173482.0 28614.3 29396.0 32254.8 32820.7 32854.7 40811.4 41159.4 41250.8 41289.4 42405.8 30115.7 30733.0 30923.8 31001.4 31353.2 30099.0 30114.4 30472.2 30824.5 31216.4 34113.7 34230.3 34429.0 34826.1 35019.5 29769.9 29990.9 30433.0 30940.0 31498.5 22857.0 23231.2 23305.8 23327.3 23596.5 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#2] jquery.html Cycles:180 Average:33043.00 Median:12809.51 stddev:76748.11 (599.1%) stddev-sans-first:76924.68 17:04:51 INFO - PID 15545 | Values: 570.1 574.9 575.7 589.2 602.5 20741.2 21349.8 21510.6 21688.8 21705.9 23073.1 23318.0 23367.9 23434.6 24175.0 6484.8 6675.2 6676.0 6680.7 6703.0 6571.5 6677.0 6688.0 6690.7 6692.9 6077.8 6607.0 6640.9 6655.6 6663.6 6208.8 6276.4 6326.7 6335.8 6350.2 5901.9 5906.4 5918.4 5921.8 5928.3 27416.0 27594.3 28269.2 28368.2 28516.0 1978.2 2027.7 2041.7 2044.4 2048.6 19307.4 19508.4 19630.9 19636.7 19684.2 2325.1 2346.6 2366.5 2370.9 2458.7 118989.0 123535.4 127125.0 133306.3 134764.3 14707.8 14707.9 14714.6 14808.0 14955.3 23293.9 23428.2 23572.9 23584.9 23625.4 9122.9 9249.6 9259.6 9321.0 9344.7 8088.2 8236.5 8269.9 8310.2 8386.5 8836.3 9015.7 9082.6 9115.5 9124.6 2568.9 2587.2 2705.7 2739.8 2848.6 954.8 959.6 967.6 969.1 970.2 19088.6 19199.0 19308.4 19535.2 19739.9 985.1 1003.5 1005.4 1009.8 1016.5 10436.4 10794.2 10834.8 10905.3 10906.2 430729.0 449041.0 459452.0 467249.0 471638.0 105419.0 107652.5 108367.0 110919.4 111335.0 1028.6 1117.8 1148.0 1163.1 1164.2 20086.0 20282.0 20695.5 20720.1 21005.4 53057.2 54419.0 54477.0 55100.0 56967.0 65781.7 68348.3 68876.7 69369.0 69760.0 14404.5 14542.1 14545.5 14653.1 14681.9 22247.7 22387.6 22557.5 22637.1 23028.5 17683.7 17797.6 17820.7 18132.0 18382.6 16424.7 16730.5 16746.4 16766.8 17076.5 18188.6 18647.3 18768.5 18792.8 18795.2 14277.4 14585.9 14618.9 14881.8 15065.4 18045.5 18277.8 18441.8 18651.3 18687.3 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#3] mootools.html Cycles:180 Average:9435.02 Median:2578.63 stddev:6779.77 (262.9%) stddev-sans-first:6771.33 17:04:51 INFO - PID 15545 | Values: 1312.7 1404.2 1405.9 1410.1 1438.8 14778.7 15475.9 15499.9 15506.0 15536.9 15087.0 15098.8 15311.6 15434.3 15442.5 2694.6 2719.2 2769.8 2770.1 2772.0 2528.4 2537.1 2539.2 2541.5 2543.4 2547.4 2617.1 2632.7 2633.4 2647.5 2563.6 2661.9 2698.2 2723.3 2723.3 2556.3 2593.7 2633.7 2635.2 2645.2 14690.3 15021.5 15045.3 15047.5 15055.8 7740.3 7990.3 7993.2 8015.2 8027.6 4873.7 5307.8 5445.0 5480.9 5538.8 1803.4 1870.0 1880.9 1896.3 1935.5 24213.2 25211.5 25266.4 26277.7 26955.5 7068.3 7081.0 7089.2 7337.9 7366.7 20268.6 20428.4 20430.0 20449.8 20514.6 8015.7 8074.2 8095.8 8128.5 8150.9 7155.1 7226.2 7429.6 7438.6 7516.7 5471.7 5597.2 5663.0 5713.7 5758.7 1674.3 1679.4 1679.9 1700.2 1728.4 907.3 922.6 923.4 931.5 933.5 7729.8 7775.3 7795.3 7934.2 7954.8 696.7 703.9 705.4 707.7 717.2 4734.8 4744.9 4753.2 4803.6 4826.4 20680.7 21606.0 21632.6 21787.3 21933.6 20787.1 21076.9 21311.4 21500.4 21573.2 11296.7 11666.2 11674.1 11687.4 11827.6 8076.0 8129.7 8231.3 8234.1 8283.7 17685.3 18596.4 18858.3 19170.3 19258.0 18375.2 19055.6 19066.0 19780.8 19953.5 12424.1 12429.9 12482.8 12499.1 12514.4 14006.3 14012.5 14116.2 14347.3 14392.9 11602.4 11928.0 11972.3 11978.6 12009.3 11644.6 11675.4 11687.5 11688.6 11737.4 9588.2 9663.3 9805.6 9884.7 9903.3 6604.3 6604.9 6626.0 6709.7 6749.7 6714.9 6852.6 6894.5 6911.2 7057.5 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#4] prototype.html Cycles:180 Average:5402.92 Median:6107.31 stddev:1493.21 (24.4%) stddev-sans-first:1451.69 17:04:51 INFO - PID 15545 | Values: 517.8 517.8 533.0 536.0 542.5 6153.7 6153.8 6182.1 6229.8 6239.0 6097.1 6117.5 6119.6 6154.6 6162.8 5085.6 5088.7 5101.6 5116.7 5123.7 5067.1 5089.5 5101.4 5108.4 5148.9 4808.7 4898.1 4899.1 4899.7 4906.6 4875.0 4880.2 4897.1 4927.0 4938.4 4384.1 4399.3 4405.2 4467.6 4484.0 5898.5 5908.5 5923.3 5942.2 5970.6 5604.9 5651.4 5677.1 5708.5 5715.2 6350.7 6372.4 6384.6 6444.5 6463.8 4627.8 4723.5 4781.4 4820.2 4833.5 6495.9 6584.9 6598.6 6636.7 6708.6 4899.2 4904.2 4933.2 4939.3 4981.2 5003.4 5005.2 5015.0 5038.0 5062.7 5566.0 5585.0 5588.4 5618.7 5646.4 6272.8 6408.9 6511.6 6548.7 6563.6 1719.8 1745.1 1749.0 1756.1 1768.5 1165.2 1221.8 1229.1 1239.9 1251.2 5550.3 5604.0 5627.3 5658.3 5670.3 6567.7 6572.6 6601.5 6671.4 6678.3 5501.7 5573.4 5582.8 5602.9 5699.3 3401.9 3408.6 3425.4 3450.4 3496.1 6259.9 6267.4 6286.6 6317.9 6417.1 6207.0 6590.4 6694.1 6737.8 6772.9 6246.9 6280.3 6296.5 6299.5 6404.5 6383.0 6399.8 6442.9 6537.6 6577.9 6321.9 6385.6 6433.1 6464.0 6467.5 6277.9 6289.2 6306.3 6310.3 6324.3 4784.0 4886.8 4907.5 4930.0 4988.2 6318.0 6499.6 6557.8 6561.5 6660.2 6227.4 6331.9 6359.9 6463.0 6501.5 6337.5 6371.3 6403.4 6454.9 6465.0 6310.7 6335.2 6340.3 6362.7 6387.4 6356.5 6396.9 6438.5 6460.9 6465.7 6170.2 6200.1 6222.5 6295.8 6304.5 17:04:51 INFO - PID 15545 | 17:04:51 INFO - PID 15545 | [#5] yui.html Cycles:180 Average:22995.60 Median:20082.35 stddev:32555.71 (162.1%) stddev-sans-first:32604.73 17:04:51 INFO - PID 15545 | Values: 891.3 891.8 904.6 907.1 908.8 19621.3 19995.2 20070.0 20094.7 20159.2 18147.8 18315.4 18354.0 18414.3 18563.6 960.7 975.6 978.8 985.1 991.6 975.0 976.6 979.5 983.0 985.3 988.2 1013.5 1028.6 1037.7 1041.0 995.2 1001.8 1005.4 1008.4 1013.2 723.4 725.9 726.0 732.1 733.3 19196.1 19616.6 19735.7 19941.7 20379.2 21195.6 21235.7 21648.0 21672.3 21697.9 16446.3 16615.2 16792.2 16797.2 16858.7 3629.3 3634.6 3642.1 3647.3 3650.4 102383.5 105426.5 134736.0 137764.0 141595.3 13595.3 14008.6 14109.2 14111.9 14144.3 30106.4 30405.4 30945.2 31018.2 31167.7 9194.6 9223.8 9244.0 9251.9 9277.4 4250.4 4342.2 4405.8 4408.8 4427.9 5337.1 5380.7 5409.3 5430.9 5454.8 987.1 995.2 1018.5 1019.4 1022.4 670.2 679.6 685.9 694.6 700.9 12139.3 12219.9 12361.8 12615.4 12987.2 692.2 695.8 702.6 717.4 718.1 5674.4 5700.7 5707.4 5841.6 5855.6 114316.0 116724.0 117447.0 117903.4 121517.0 97274.5 98793.5 100798.5 101824.0 102767.0 81383.0 85873.6 86951.0 87154.0 89625.0 10290.8 10353.9 10706.1 10721.6 10808.7 42791.1 43511.0 43673.0 43900.3 44013.3 53629.7 55460.7 55557.4 55557.7 56315.0 14682.6 14791.9 14843.8 14870.9 15004.5 17726.3 17778.2 17928.4 17946.5 18095.4 15296.5 15358.2 15579.8 15605.1 15689.3 14524.9 14686.9 14702.6 14799.3 14887.7 15425.4 15456.5 15654.1 15757.9 15959.7 10251.8 10404.3 10458.5 10560.2 10617.5 10844.3 10904.3 10927.0 10969.3 11080.5 17:04:51 INFO - PID 15545 | -------- Summary: end -------- 17:04:51 INFO - PID 15545 | 17:04:52 INFO - TEST-INFO | 15545: exit 0 17:04:52 INFO - TEST-OK | dromaeo_css | took 1115508ms 17:04:52 INFO - TEST-START | kraken 17:04:52 INFO - Initialising browser for kraken test... 17:04:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54553/getInfo.html -profile /tmp/tmpNKwfw8/profile 17:04:52 INFO - TEST-INFO | started process 15925 (/builds/slave/test/build/application/firefox/firefox http://localhost:54553/getInfo.html) 17:04:59 INFO - TEST-INFO | 15925: exit 0 17:04:59 INFO - Browser initialized. 17:04:59 INFO - Running cycle 1/1 for kraken test... 17:04:59 INFO - Using env: {'DISPLAY': ':0', 17:04:59 INFO - 'HOME': '/home/cltbld', 17:04:59 INFO - 'JSGC_DISABLE_POISONING': '1', 17:04:59 INFO - 'LANG': 'en_US.UTF-8', 17:04:59 INFO - 'LANGUAGE': 'en_US:en', 17:04:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:04:59 INFO - 'LOGNAME': 'cltbld', 17:04:59 INFO - 'MAIL': '/var/mail/cltbld', 17:04:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:59 INFO - 'MOZ_ACCELERATED': '1', 17:04:59 INFO - 'MOZ_CRASHREPORTER': '1', 17:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:04:59 INFO - 'MOZ_NO_REMOTE': '1', 17:04:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:59 INFO - 'MOZ_WEBRENDER': '1', 17:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:59 INFO - 'NO_EM_RESTART': '1', 17:04:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:59 INFO - 'PWD': '/builds/slave/test', 17:04:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:59 INFO - 'RUST_BACKTRACE': 'full', 17:04:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:04:59 INFO - 'SHELL': '/bin/bash', 17:04:59 INFO - 'SHLVL': '1', 17:04:59 INFO - 'TERM': 'linux', 17:04:59 INFO - 'TMOUT': '86400', 17:04:59 INFO - 'USER': 'cltbld', 17:04:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506555918.681044-492989850', 17:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:59 INFO - '_': '/tools/buildbot/bin/python'} 17:04:59 INFO - TEST-INFO | started process 16172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKwfw8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:00 INFO - PID 16172 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:05:00 INFO - PID 16172 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:05:00 INFO - PID 16172 | 17:05:00 INFO - PID 16172 | (/builds/slave/test/build/application/firefox/firefox:16231): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:05:00 INFO - PID 16172 | 17:05:10 INFO - PID 16172 | RSS: Main: 206581760 17:05:10 INFO - PID 16172 | 17:05:13 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:14 INFO - PID 16172 | RSS: Main: 203333632 17:05:14 INFO - PID 16172 | 17:05:17 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-dft) 17:05:17 INFO - PID 16172 | RSS: Main: 203284480 17:05:17 INFO - PID 16172 | 17:05:20 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-fft) 17:05:21 INFO - PID 16172 | RSS: Main: 200126464 17:05:21 INFO - PID 16172 | 17:05:23 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator) 17:05:24 INFO - PID 16172 | RSS: Main: 200015872 17:05:24 INFO - PID 16172 | 17:05:26 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:27 INFO - PID 16172 | RSS: Main: 200642560 17:05:27 INFO - PID 16172 | 17:05:30 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:30 INFO - PID 16172 | RSS: Main: 203173888 17:05:30 INFO - PID 16172 | 17:05:34 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:35 INFO - PID 16172 | RSS: Main: 202555392 17:05:35 INFO - PID 16172 | 17:05:38 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial) 17:05:38 INFO - PID 16172 | RSS: Main: 203202560 17:05:38 INFO - PID 16172 | 17:05:40 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:41 INFO - PID 16172 | RSS: Main: 203534336 17:05:41 INFO - PID 16172 | 17:05:42 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:43 INFO - PID 16172 | RSS: Main: 203059200 17:05:43 INFO - PID 16172 | 17:05:45 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:46 INFO - PID 16172 | RSS: Main: 203448320 17:05:46 INFO - PID 16172 | 17:05:49 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:49 INFO - PID 16172 | RSS: Main: 203788288 17:05:49 INFO - PID 16172 | 17:05:52 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:53 INFO - PID 16172 | RSS: Main: 203956224 17:05:53 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54553/tests/kraken/driver.html?testName=ai-astar) 17:05:55 INFO - PID 16172 | RSS: Main: 205271040 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | __start_tp_report 17:05:55 INFO - PID 16172 | _x_x_mozilla_page_load 17:05:55 INFO - PID 16172 | _x_x_mozilla_page_load_details 17:05:55 INFO - PID 16172 | |i|pagename|runs| 17:05:55 INFO - PID 16172 | |0;ai-astar;110;108;117;115;109;114;107;118;111;107 17:05:55 INFO - PID 16172 | |1;audio-beat-detection;127;124;122;117;123;118;150;120;122;148 17:05:55 INFO - PID 16172 | |2;audio-dft;165;162;169;168;167;168;167;173;165;169 17:05:55 INFO - PID 16172 | |3;audio-fft;80;80;77;92;80;74;83;85;74;77 17:05:55 INFO - PID 16172 | |4;audio-oscillator;88;86;89;84;83;85;83;82;87;81 17:05:55 INFO - PID 16172 | |5;imaging-gaussian-blur;122;120;114;115;115;114;115;117;119;119 17:05:55 INFO - PID 16172 | |6;imaging-darkroom;148;147;148;149;162;154;148;149;149;148 17:05:55 INFO - PID 16172 | |7;imaging-desaturate;94;99;94;98;102;104;103;95;94;103 17:05:55 INFO - PID 16172 | |8;json-parse-financial;55;60;55;55;54;54;52;52;53;52 17:05:55 INFO - PID 16172 | |9;json-stringify-tinderbox;39;38;41;46;38;49;46;39;39;39 17:05:55 INFO - PID 16172 | |10;stanford-crypto-aes;79;77;76;79;80;71;79;81;73;82 17:05:55 INFO - PID 16172 | |11;stanford-crypto-ccm;120;116;117;119;118;124;114;114;125;116 17:05:55 INFO - PID 16172 | |12;stanford-crypto-pbkdf2;177;184;167;183;169;178;166;170;174;172 17:05:55 INFO - PID 16172 | |13;stanford-crypto-sha256-iterative;74;66;71;64;70;72;82;64;65;66 17:05:55 INFO - PID 16172 | __end_tp_report 17:05:55 INFO - PID 16172 | __start_cc_report 17:05:55 INFO - PID 16172 | _x_x_mozilla_cycle_collect,746 17:05:55 INFO - PID 16172 | __end_cc_report 17:05:55 INFO - PID 16172 | __startTimestamp1506557155345__endTimestamp 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | ------- Summary: start ------- 17:05:55 INFO - PID 16172 | Number of tests: 14 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:4.32 17:05:55 INFO - PID 16172 | Values: 110.0 108.0 117.0 115.0 109.0 114.0 107.0 118.0 111.0 107.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:123.50 stddev:11.90 (9.6%) stddev-sans-first:12.62 17:05:55 INFO - PID 16172 | Values: 127.0 124.0 122.0 117.0 123.0 118.0 150.0 120.0 122.0 148.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#2] audio-dft Cycles:10 Average:167.30 Median:168.00 stddev:2.95 (1.8%) stddev-sans-first:3.00 17:05:55 INFO - PID 16172 | Values: 165.0 162.0 169.0 168.0 167.0 168.0 167.0 173.0 165.0 169.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#3] audio-fft Cycles:10 Average:80.20 Median:80.00 stddev:5.45 (6.8%) stddev-sans-first:5.78 17:05:55 INFO - PID 16172 | Values: 80.0 80.0 77.0 92.0 80.0 74.0 83.0 85.0 74.0 77.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#4] audio-oscillator Cycles:10 Average:84.80 Median:85.50 stddev:2.66 (3.1%) stddev-sans-first:2.55 17:05:55 INFO - PID 16172 | Values: 88.0 86.0 89.0 84.0 83.0 85.0 83.0 82.0 87.0 81.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:118.00 stddev:2.83 (2.4%) stddev-sans-first:2.35 17:05:55 INFO - PID 16172 | Values: 122.0 120.0 114.0 115.0 115.0 114.0 115.0 117.0 119.0 119.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.00 stddev:4.57 (3.1%) stddev-sans-first:4.77 17:05:55 INFO - PID 16172 | Values: 148.0 147.0 148.0 149.0 162.0 154.0 148.0 149.0 149.0 148.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:94.00 stddev:4.17 (4.4%) stddev-sans-first:4.08 17:05:55 INFO - PID 16172 | Values: 94.0 99.0 94.0 98.0 102.0 104.0 103.0 95.0 94.0 103.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:2.39 (4.4%) stddev-sans-first:2.52 17:05:55 INFO - PID 16172 | Values: 55.0 60.0 55.0 55.0 54.0 54.0 52.0 52.0 53.0 52.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#9] json-stringify-tinderbox Cycles:10 Average:41.40 Median:40.00 stddev:4.03 (10.1%) stddev-sans-first:4.18 17:05:55 INFO - PID 16172 | Values: 39.0 38.0 41.0 46.0 38.0 49.0 46.0 39.0 39.0 39.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:79.00 stddev:3.50 (4.4%) stddev-sans-first:3.68 17:05:55 INFO - PID 16172 | Values: 79.0 77.0 76.0 79.0 80.0 71.0 79.0 81.0 73.0 82.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:118.50 stddev:3.80 (3.2%) stddev-sans-first:3.98 17:05:55 INFO - PID 16172 | Values: 120.0 116.0 117.0 119.0 118.0 124.0 114.0 114.0 125.0 116.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.50 stddev:6.36 (3.6%) stddev-sans-first:6.65 17:05:55 INFO - PID 16172 | Values: 177.0 184.0 167.0 183.0 169.0 178.0 166.0 170.0 174.0 172.0 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.50 stddev:5.68 (8.1%) stddev-sans-first:5.78 17:05:55 INFO - PID 16172 | Values: 74.0 66.0 71.0 64.0 70.0 72.0 82.0 64.0 65.0 66.0 17:05:55 INFO - PID 16172 | -------- Summary: end -------- 17:05:55 INFO - PID 16172 | 17:05:55 INFO - PID 16172 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:05:56 INFO - TEST-INFO | 16172: exit 0 17:05:56 INFO - TEST-OK | kraken | took 63690ms 17:05:56 INFO - SUITE-END | took 1179s 17:05:56 INFO - Completed test suite (00:19:39) 17:05:56 INFO - javascript benchmark 17:05:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8373.55947929424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3193.792403493773, 3235.838208089596, 3236.6763323667637, 3289.588801399825, 3294.5552350432686, 6217.409346112124, 6289.371062893714, 6317.810465686037, 6336.809895703131, 6377.04344348348, 6236.968815155918, 6329.208848893888, 6338.841528961778, 6348.936510634892, 6359.71381287842, 5765.596408251424, 5800.390958949291, 5835.44563266489, 5838.854028649275, 5898.7640494380175, 5829.999999999979, 5886.970565147169, 5888.440598143169, 5910.527157827363, 5993.490553302974, 5871.500922421599, 5886.352501224862, 5942.7920022799, 5960.79137230197, 5989.610675306113, 5664.433556644302, 5734.111212762028, 5771.797987070432, 5868.823935281948, 5892.616979896293, 5771.769129234825, 5784.768609255625, 5854.736536855852, 5875.441833025856, 5903.557233207526, 6203.658798766066, 6310.8106756796915, 6360.618362898241, 6389.872202555923, 6415.935840641627, 6739.5619284746335, 6820.965895170542, 6842.794716158523, 6857.451403887677, 6877.0, 6874.759383421606, 6876.553024053471, 6904.551204171713, 6914.412274956584, 6924.376806087426, 6242.344553821874, 6290.528210384239, 6309.337519560426, 6369.904451433186, 6393.232812062536, 6884.586924784529, 6923.238443771181, 6950.443964482829, 6967.303269672992, 7008.0, 6586.077949087132, 6648.235452922879, 6650.20197576294, 6691.431228345547, 6695.665216739144, 6781.186257649114, 6790.796276111724, 6804.081449004321, 6813.863722725518, 6815.182178138655, 6620.404163625297, 6850.109485766819, 6855.5543889647015, 6857.897131543031, 6870.656467176621, 6773.62745049027, 6777.2545020047755, 6795.7961261162245, 6899.655017249117, 6938.722451102, 4927.063857866994, 4966.925496117489, 4993.425756038102, 5009.524095210949, 5061.8357777711335, 4395.626371758436, 4428.22506061438, 4438.778061096932, 4462.107578484316, 4484.192845287815, 5849.678267695318, 5875.118732190205, 5886.735096920564, 5888.116782482662, 5921.319048309413, 6861.142357205349, 6876.312368763083, 6942.479314051467, 6964.825879353057, 6977.1278590176225, 5645.576581756302, 5801.332846722681, 5826.82519524415, 5830.650160990354, 5832.650040997553, 5857.736401861841, 5888.234529511136, 5897.616654917502, 5903.498202652737, 5921.378255283219, 6614.10709554204, 6670.4997125215805, 6701.262861085277, 6701.899471507932, 6714.429273511709, 6870.27862074495, 6870.931290687029, 6929.965350173217, 6949.583025018616, 6993.965030174817, 6418.133551970611, 6577.177852768404, 6624.6025238485845, 6720.697568609522, 6721.899171512529, 6621.1392518972225, 6646.734130634721, 6649.434798042221, 6660.2673705893285, 6687.665616719242, 6664.966675166593, 6717.1267735194115, 6782.0, 6789.728410863708, 6797.72809087631, 6613.867722645424, 6638.302978187414, 6652.2349929756765, 6664.133662623828, 6682.264950855305, 6589.967050164719, 6614.470842332698, 6671.499637527108, 6687.03038059469, 6693.431058360094, 6428.485721142204, 6489.5781774184525, 6546.639934803441, 6653.367930046637, 6669.09967154428, 6609.074729537772, 6640.0, 6662.100616416722, 6672.032555279555, 6686.197656281277, 6381.3937675920715, 6388.265349484869, 6393.232812062396, 6446.709898054505, 6460.515461340512], "value": 6183.773529061185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.7863644770583, 855.3542075732821, 858.5664239559023, 862.4264863865534, 862.7454900804262, 37846.0, 38470.038249043755, 40621.187576248456, 40863.38704919425, 41058.17883642333, 37730.62269377305, 38004.61995380045, 38008.239835203276, 38125.618743812556, 38308.0, 7104.7513337033215, 7236.421086313108, 7249.093863267091, 7257.637118144072, 7262.419006479469, 7115.7153713851385, 7122.0, 7193.42452603793, 7196.604186769726, 7197.3882220011365, 7124.394426473756, 7134.7859564212895, 7197.8920316195035, 7200.675969581382, 7232.674529646152, 7104.928950710479, 7763.0684317882215, 8004.159563245892, 8006.879896801553, 8068.798280043045, 7986.800329991796, 8056.556889371082, 8060.153683863168, 8072.596370181526, 8091.757247282591, 36307.4553881692, 36449.453258201145, 36549.63450365516, 37065.814670926746, 37096.629033709854, 3513.508108864761, 3567.7859328440377, 3577.0878426001464, 3589.246258285763, 3589.4795254688183, 31743.52384714231, 31990.840045799854, 32118.518222226685, 32288.354232915444, 32357.83821080903, 4538.2738761797955, 4543.727376357396, 4638.698484598524, 4649.395578574798, 4675.2052151134385, 175987.0, 176124.0, 176854.0, 177415.11292443585, 178790.10604946892, 40301.99999999941, 41659.58340416557, 47051.52948470471, 47248.76375618169, 47372.0, 48414.5158548417, 48681.0, 48805.75597122063, 48893.51106488961, 49283.50716492789, 14800.703985920221, 14914.776278355834, 14973.401063957537, 15028.474003409829, 15059.096454212782, 12000.519979200733, 12021.338826364634, 12042.81935770964, 12053.819192712117, 12062.87937120635, 13236.801447978289, 13250.668733281746, 13360.866391335961, 13412.865871341357, 13657.658558536115, 5451.890962180734, 5560.833175004756, 5609.80365687199, 5614.101743720985, 5661.0, 1004.7940172264668, 1012.9493525323852, 1023.1967905194387, 1030.5414090729703, 1035.140833108518, 22248.77751222467, 22710.52381595191, 22806.42983925382, 22957.426064348525, 23188.65217021746, 1114.3171817144416, 1126.5550107707575, 1131.671815173607, 1134.472470301314, 1139.0887290167832, 12183.0, 12275.263484190977, 12335.6916077097, 12389.814152787716, 12391.690207744698, 219935.0, 220046.79953200583, 220703.0, 222294.0, 222584.0, 49529.50470495249, 49604.0, 49666.50333496619, 49766.0, 49783.751081244365, 1410.5627255550812, 1437.8798008321967, 1469.897107202507, 1472.6244807574, 1480.8815294776177, 22322.553548929256, 22512.887435563374, 22558.77441225567, 22848.31455056351, 22873.31380058601, 35951.64048359483, 35996.28007439889, 36000.27999439944, 36007.45988810118, 36165.45751813777, 170432.0, 171180.0, 171726.14136929237, 172675.0, 173482.0, 28614.284642884093, 29396.0, 32254.83872580622, 32820.67179328176, 32854.67145328516, 40811.38782918318, 41159.38260926028, 41250.79374603108, 41289.380659290735, 42405.787971059945, 30115.69884301129, 30733.0, 30923.845380772953, 31001.37997240088, 31353.216169595944, 30099.0, 30114.397712046073, 30472.238194045327, 30824.537631935986, 31216.375672486876, 34113.658863411045, 34230.31539369149, 34429.0, 34826.12934676653, 35019.47470787991, 29769.851150744107, 29990.85004574963, 30433.0, 30940.0, 31498.527522087647, 22857.0, 23231.186908458123, 23305.766942331036, 23327.300180994596, 23596.528069438173], "value": 16487.479258678835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1362435909598, 574.8993926062943, 575.6574837971408, 589.2281111743615, 602.5029350785602, 20741.170353185855, 21349.786502134975, 21510.56978860424, 21688.783112168872, 21705.891470542665, 23073.077076916903, 23318.0, 23367.883160584217, 23434.64848027277, 24175.0, 6484.773032943848, 6675.232348279961, 6676.0, 6680.699368528428, 6703.0, 6571.474282057424, 6677.0, 6687.966560167217, 6690.7323707051655, 6692.93307066928, 6077.7568897244055, 6607.0, 6640.900386494206, 6655.567388119756, 6663.566868153554, 6208.78269260576, 6276.435120839124, 6326.715297811586, 6335.8416039598915, 6350.237971443456, 5901.881962360729, 5906.409359064102, 5918.3785702501045, 5921.763129474816, 5928.258967629046, 27416.0, 27594.310142246402, 28269.15192544227, 28368.156069855395, 28516.0, 1978.1691689490306, 2027.6552985992269, 2041.6529190037581, 2044.396902913644, 2048.5800410915726, 19307.4207773767, 19508.414747557596, 19630.901845490826, 19636.70544941827, 19684.212631494724, 2325.1396983116188, 2346.554154710617, 2366.491204391064, 2370.8577485350934, 2458.704955405363, 118989.0, 123535.3823230878, 127125.0, 133306.33346833204, 134764.32617836847, 14707.823374130045, 14707.926460367844, 14714.55856324312, 14808.037477563925, 14955.325910971827, 23293.883530582578, 23428.18001369944, 23572.88213558921, 23584.882075589856, 23625.40936476602, 9122.86315705265, 9249.583768730423, 9259.629614815467, 9320.953395233117, 9344.719658410258, 8088.191180881982, 8236.546989915612, 8269.875951860728, 8310.21052999964, 8386.454880432751, 8836.293096552261, 9015.729528114167, 9082.636694532144, 9115.544222788834, 9124.58939347731, 2568.948621027569, 2587.1721049264056, 2705.7294270572784, 2739.8080637192807, 2848.6154369160313, 954.7660823098386, 959.6451798961776, 967.5645959318335, 969.1277849935115, 970.2238209432426, 19088.61822763565, 19199.040047997543, 19308.4207473776, 19535.218591256475, 19739.901300493406, 985.1281615770096, 1003.5484032185545, 1005.3766664667953, 1009.833642143311, 1016.5222345497605, 10436.37381757097, 10794.190435717353, 10834.837477437844, 10905.291156074829, 10906.236563440641, 430729.0, 449041.0, 459452.0, 467249.0, 471638.0, 105419.0, 107652.46173769081, 108367.0, 110919.44540277247, 111335.0, 1028.573142146016, 1117.8379135025375, 1147.9827802582968, 1163.1334655681571, 1164.2083383299268, 20086.0, 20282.0, 20695.482612934797, 20720.067596958474, 21005.36983890486, 53057.20414193713, 54419.0, 54477.0, 55100.0, 56967.0, 65781.67109164424, 68348.3165168342, 68876.65561672159, 69369.0, 69760.0, 14404.495842645458, 14542.127472351693, 14545.490907818175, 14653.12081275127, 14681.92659036698, 22247.666285005413, 22387.552248955257, 22557.548849023256, 22637.094516219167, 23028.53942921099, 17683.73474397859, 17797.644047118727, 17820.732689009936, 18132.0, 18382.632347353247, 16424.67150657004, 16730.49808505698, 16746.4138755143, 16766.832331677015, 17076.487705368858, 18188.636227275114, 18647.254109835998, 18768.53078673044, 18792.812071879107, 18795.154218060492, 14277.357518911882, 14585.92707036458, 14618.926905365404, 14881.776773348625, 15065.397384104514, 18045.458636240935, 18277.817221827612, 18441.81558184401, 18651.347202847835, 18687.345942892476], "value": 11714.481401349525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.744014917091, 1404.192589261175, 1405.9015868889182, 1410.1116296733057, 1438.798568200452, 14778.704425911488, 15475.922620386911, 15499.922500387496, 15506.0, 15536.922315388421, 15087.01934374265, 15098.773518397205, 15311.617209569766, 15434.305456254468, 15442.459513917016, 2694.6362241097495, 2719.1978366381913, 2769.7507224349806, 2770.0720258713354, 2771.9584206236923, 2528.3552694062987, 2537.099329737944, 2539.21284401836, 2541.4789968056502, 2543.4023004593996, 2547.426828963487, 2617.084020592796, 2632.7104018557943, 2633.3943193065606, 2647.4969755746442, 2563.5513785087537, 2661.8935242590273, 2698.17705599792, 2723.2783312422225, 2723.305557082951, 2556.335352808265, 2593.714691383946, 2633.710291867893, 2635.235781623327, 2645.2196602002455, 14690.265486725728, 15021.549353519302, 15045.322960466805, 15047.548573542812, 15055.849441505554, 7740.303372696428, 7990.280874721245, 7993.240642138988, 8015.238552337577, 8027.598620068973, 4873.707577545323, 5307.787688492455, 5445.0, 5480.945190548123, 5538.778448862041, 1803.386848471526, 1870.0, 1880.8683392162554, 1896.2888916656254, 1935.4967708395918, 24213.152539661205, 25211.495770084497, 25266.36834079163, 26277.73722262772, 26955.46089078227, 7068.3285087916565, 7081.0, 7089.184743754431, 7337.88993165103, 7366.742164024341, 20268.594628107356, 20428.387148385573, 20430.0, 20449.795502044788, 20514.589708205753, 8015.719449819228, 8074.232947869943, 8095.797605059921, 8128.512289262545, 8150.877736833952, 7155.141383034069, 7226.241244669339, 7429.591372474566, 7438.5536867788105, 7516.699332026657, 5471.671699698031, 5597.188407680945, 5662.971685141631, 5713.685747283939, 5758.654480731169, 1674.3051633571931, 1679.420599893035, 1679.8908070975347, 1700.1839117223801, 1728.4209789720333, 907.2696479334068, 922.6447817590276, 923.3536524432924, 931.4690626343055, 933.5472295936465, 7729.768106956801, 7775.339096176888, 7795.259450352208, 7934.206579342135, 7954.761357159295, 696.6551556979327, 703.9366457018892, 705.4497491956282, 707.6956908529381, 717.1645033535872, 4734.786934587952, 4744.932390212175, 4753.191957367256, 4803.615710743132, 4826.420829500483, 20680.689789653166, 21606.0, 21632.567348652938, 21787.346379608636, 21933.561328773336, 20787.06458209384, 21076.894615526824, 21311.36065918025, 21500.354989350344, 21573.244936427465, 11296.717582060513, 11666.183367164387, 11674.066074714003, 11687.415629218505, 11827.645170644895, 8075.959620202097, 8129.715459958873, 8231.300339470972, 8234.135415781257, 8283.710070147516, 17685.292588296837, 18596.44210673682, 18858.30275275232, 19170.329038483585, 19258.037098144756, 18375.173117210026, 19055.618887622448, 19065.996140810585, 19780.802191977895, 19953.501162471053, 12424.06819488524, 12429.875701242872, 12482.75034499323, 12499.125061245626, 12514.43685034194, 14006.299685015912, 14012.509562165274, 14116.223607701675, 14347.282635867956, 14392.85607143957, 11602.361870097226, 11928.0, 11972.341521216069, 11978.64064078079, 12009.279443233434, 11644.592439264585, 11675.35785531804, 11687.532498699957, 11688.649340519798, 11737.413129343327, 9588.185004274435, 9663.323567350499, 9805.558749856416, 9884.654037108667, 9903.306768526421, 6604.306547812603, 6604.900926486011, 6625.966870165811, 6709.664516774044, 6749.73001079971, 6714.9328506716265, 6852.623105729033, 6894.517383783087, 6911.239763626098, 7057.470689698191], "value": 6662.60952591468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.8161752577835, 517.8342930262318, 533.0257165019192, 535.9624826262163, 542.5036091975842, 6153.661548614825, 6153.8461538461515, 6182.134501169834, 6229.781957631484, 6238.968805155979, 6097.146399504073, 6117.480014198787, 6119.602225855317, 6154.599951003182, 6162.815115546541, 5085.593152547805, 5088.694678319294, 5101.617378696594, 5116.70197034491, 5123.692578445287, 5067.111746304608, 5089.491050894918, 5101.38783345999, 5108.438071812097, 5148.897022059557, 4808.735519546423, 4898.118338699032, 4899.118158731427, 4899.657024008303, 4906.582940450066, 4874.951250487521, 4880.24356224784, 4897.094037603055, 4926.950730492685, 4938.432080310774, 4384.145091707119, 4399.318105693623, 4405.163019026407, 4467.5755803198645, 4483.977580112111, 5898.528117750569, 5908.468237858613, 5923.289205295392, 5942.227510423617, 5970.641761494324, 5604.887902241932, 5651.378348381675, 5677.120046392815, 5708.4862362387585, 5715.199872017921, 6350.745970161188, 6372.426481616677, 6384.648844313561, 6444.484441244689, 6463.7737679181, 4627.838025669119, 4723.527647235283, 4781.42622885256, 4820.228763397875, 4833.516648335173, 6495.928171851639, 6584.9012264816065, 6598.637074960923, 6636.668166591651, 6708.597484151015, 4899.216125419915, 4904.166291730415, 4933.186024305949, 4939.3084968104495, 4981.153203955337, 5003.399592048904, 5005.174146265826, 5015.0, 5038.042771873333, 5062.670926389773, 5566.0, 5584.972075139598, 5588.3573389060775, 5618.719064046782, 5646.4353564644025, 6272.780452684226, 6408.935910640927, 6511.609303441809, 6548.6725663716625, 6563.606183628997, 1719.819418961016, 1745.1187150489175, 1748.9825101749075, 1756.1043867627602, 1768.4959786461054, 1165.1727273635645, 1221.7922953097996, 1229.1457437081322, 1239.9380030998595, 1251.205484517338, 5550.306211723535, 5604.0, 5627.268455100892, 5658.321001479849, 5670.319561652628, 6567.704453299613, 6572.572782769104, 6601.547659514899, 6671.39957403836, 6678.33216678338, 5501.697406642673, 5573.359063707644, 5582.804601838998, 5602.887942241214, 5699.316082070095, 3401.8809341672923, 3408.608010078823, 3425.4348032574344, 3450.413429716954, 3496.07715756333, 6259.874802503924, 6267.435930766253, 6286.622802631857, 6317.873642527215, 6417.133686952295, 6207.020630097579, 6590.406863382319, 6694.054615969056, 6737.764178253738, 6772.8984065239065, 6246.9062964054665, 6280.340564240689, 6296.496280297565, 6299.496040316855, 6404.48764098871, 6382.9999900046905, 6399.84802735512, 6442.935570644421, 6537.607743535403, 6577.934220657732, 6321.936780632135, 6385.616862988049, 6433.099366088658, 6463.967680161569, 6467.514936379696, 6277.91935242078, 6289.182406287154, 6306.342321453638, 6310.286576772032, 6324.300284333716, 4783.976080119577, 4886.82716148129, 4907.478681608713, 4929.950700493093, 4988.201887697951, 6317.96841015792, 6499.610023398611, 6557.770478033246, 6561.540692151503, 6660.167479065117, 6227.377262273736, 6331.873362532816, 6359.904601431075, 6463.0, 6501.4798816095545, 6337.461315788025, 6371.331010244043, 6403.3596640337455, 6454.935450645434, 6465.0, 6310.716017779303, 6335.176427064452, 6340.270868850142, 6362.650054246876, 6387.361263873576, 6356.5232607555545, 6396.936030639634, 6438.517111216771, 6460.870782584416, 6465.676716164267, 6170.197874276315, 6200.054973887368, 6222.471089957405, 6295.811125666238, 6304.5271604628915], "value": 4970.138688082719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.313688459886, 891.7592250092474, 904.5838914099514, 907.0883761819371, 908.7864351877307, 19621.31325403611, 19995.20019199234, 20069.99999999998, 20094.69857952132, 20159.19363225471, 18147.81852181481, 18315.358962436316, 18354.0, 18414.26342946284, 18563.628727425443, 960.6733710538398, 975.5756246032963, 978.7602037500823, 985.0641890204299, 991.5934466868586, 974.9512524373788, 976.5947131940236, 979.5151400056982, 983.0317137619439, 985.2905907746447, 988.2489308125804, 1013.5185786751271, 1028.5680014393936, 1037.7094413564214, 1041.0214398465419, 995.1740055753743, 1001.8246806808852, 1005.3917379985113, 1008.4403156248279, 1013.2248829645328, 723.4284914917209, 725.8947452619393, 725.961874519437, 732.0922056649716, 733.2740586819064, 19196.13617387207, 19616.60766784656, 19735.703964440545, 19941.700874486894, 20379.18483260668, 21195.576088478298, 21235.68146477804, 21648.0, 21672.34982950514, 21697.891510542504, 16446.342146314135, 16615.169241537995, 16792.160391980353, 16797.160141992852, 16858.747118793228, 3629.2922880038404, 3634.5638523377365, 3642.1440961374055, 3647.270545890806, 3650.361186792301, 102383.48808255911, 105426.47286763517, 134736.0, 137764.0, 141595.29202354024, 13595.252261125535, 14008.579742607739, 14109.223992680501, 14111.929440352938, 14144.29278536069, 30106.397872042435, 30405.39189216203, 30945.226369340497, 31018.224544386572, 31167.68832311648, 9194.586243619053, 9223.815523689489, 9244.029376915327, 9251.861222081674, 9277.396969197116, 4250.426192463978, 4342.174986752507, 4405.84579539721, 4408.823647054082, 4427.911441771146, 5337.092694241988, 5380.650257733235, 5409.26974858397, 5430.8913821723345, 5454.7818087276855, 987.0770829274651, 995.1789773436799, 1018.4958445569342, 1019.3934608907688, 1022.412113034993, 670.1890712238246, 679.5956405938458, 685.8833998220215, 694.572837704818, 700.8948657701284, 12139.332336721565, 12219.938900305442, 12361.752764944831, 12615.432305546272, 12987.220766754024, 692.1901375390805, 695.8016965164903, 702.5538782872912, 717.3866344275674, 718.1489934427719, 5674.404187560329, 5700.686462244616, 5707.429257074259, 5841.561882858802, 5855.560832937546, 114316.0, 116724.0, 117447.0, 117903.41048294703, 121517.0, 97274.51362743283, 98793.50603247082, 100798.49600752095, 101824.0, 102767.0, 81383.0, 85873.57063214644, 86951.0, 87154.0, 89625.0, 10290.794184116425, 10353.9482302588, 10706.143508519455, 10721.571137154739, 10808.729781755519, 42791.144177116905, 43511.0, 43673.0, 43900.341494876964, 44013.33979990239, 53629.7318513405, 55460.72269638626, 55557.44442555523, 55557.722211390304, 56315.0, 14682.55952321432, 14791.92604036973, 14843.777343339643, 14870.925645371704, 15004.474843380429, 17726.290948361922, 17778.199981000627, 17928.372506962194, 17946.461606151835, 18095.36666216676, 15296.464623738117, 15358.155301458528, 15579.76630350523, 15605.141717205663, 15689.293981771076, 14524.85475145235, 14686.853131468975, 14702.55892323232, 14799.260036998323, 14887.702245954804, 15425.382984680487, 15456.459023934558, 15654.13902235388, 15757.921210393875, 15959.680806383574, 10251.84622230682, 10404.323718958243, 10458.477076146315, 10560.155187584822, 10617.522211500656, 10844.295120817122, 10904.34573925567, 10927.0, 10969.341839489656, 11080.501377437873], "value": 8715.49461267424, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 117.0, 115.0, 109.0, 114.0, 107.0, 118.0, 111.0, 107.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 122.0, 117.0, 123.0, 118.0, 150.0, 120.0, 122.0, 148.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 169.0, 168.0, 167.0, 168.0, 167.0, 173.0, 165.0, 169.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 77.0, 92.0, 80.0, 74.0, 83.0, 85.0, 74.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 84.0, 83.0, 85.0, 83.0, 82.0, 87.0, 81.0], "value": 84.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 114.0, 115.0, 115.0, 114.0, 115.0, 117.0, 119.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 162.0, 154.0, 148.0, 149.0, 149.0, 148.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 98.0, 102.0, 104.0, 103.0, 95.0, 94.0, 103.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 55.0, 55.0, 54.0, 54.0, 52.0, 52.0, 53.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 41.0, 46.0, 38.0, 49.0, 46.0, 39.0, 39.0, 39.0], "value": 41.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 76.0, 79.0, 80.0, 71.0, 79.0, 81.0, 73.0, 82.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 117.0, 119.0, 118.0, 124.0, 114.0, 114.0, 125.0, 116.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 184.0, 167.0, 183.0, 169.0, 178.0, 166.0, 170.0, 174.0, 172.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 71.0, 64.0, 70.0, 72.0, 82.0, 64.0, 65.0, 66.0], "value": 69.4, "unit": "score"}]}]} 17:05:56 INFO - Return code: 0 17:05:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:05:56 INFO - # TBPL SUCCESS # 17:05:56 INFO - Running post-action listener: _package_coverage_data 17:05:56 INFO - Running post-action listener: _resource_record_post_action 17:05:56 INFO - [mozharness: 2017-09-28 00:05:56.603315Z] Finished run-tests step (success) 17:05:56 INFO - Running post-run listener: _resource_record_post_run 17:05:56 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 9797632; Write bytes: 337948672; Read time: 8836; Write time: 246768 17:05:56 INFO - TinderboxPrint: CPU usage
13.2% 17:05:56 INFO - TinderboxPrint: I/O read bytes / time
9,797,632 / 8,836 17:05:56 INFO - TinderboxPrint: I/O write bytes / time
337,948,672 / 246,768 17:05:56 INFO - TinderboxPrint: CPU idle
8,284.4 (86.8%) 17:05:56 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 17:05:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:05:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13062144; Read time: 0; Write time: 1232 17:05:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:05:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 9793536; Write bytes: 324886528; Read time: 8820; Write time: 245536 17:05:57 INFO - Running post-run listener: _upload_blobber_files 17:05:57 INFO - Blob upload gear active. 17:05:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:57 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 17:05:57 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'] 17:05:57 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 17:05:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:58 INFO - (blobuploader) - INFO - Done attempting. 17:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:05 INFO - (blobuploader) - INFO - Done attempting. 17:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:06 INFO - (blobuploader) - INFO - Done attempting. 17:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:06:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:07 INFO - (blobuploader) - INFO - Done attempting. 17:06:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:07 INFO - Return code: 0 17:06:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:06:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237d449c5e0b8d811d46fcb30e6e4d5a5583ec8d433e16e4e1ebc81b4e8ccebb28be1c679bd18eb737e17ca84e2d567733f96aa2e819324c7a7204db89f1ed84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4208516cebbdea853e231fc40279efbd9a2f768cae3ab3a015bc728961802de416c8e0832abe43043fbb90732b549c0c980c8b69857e4593bf9ddda78362424", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c682a90caed63c5891144137df7f44e276b2ce98a5906c570f3214b6b6911a949dc44671da70a1df13c15a6f4cad4ea520e18b0a8ac40b06f2b45e52aa2f51", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebef5290cdddb60dbaf189ac3b025ea81c5b9733130467254fe50d60783b296a6c39c35676be13a4910cc745a1926f9c92a713900dccd22388a23ba30e565db8"} 17:06:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:06:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:06:07 INFO - Contents: 17:06:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237d449c5e0b8d811d46fcb30e6e4d5a5583ec8d433e16e4e1ebc81b4e8ccebb28be1c679bd18eb737e17ca84e2d567733f96aa2e819324c7a7204db89f1ed84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4208516cebbdea853e231fc40279efbd9a2f768cae3ab3a015bc728961802de416c8e0832abe43043fbb90732b549c0c980c8b69857e4593bf9ddda78362424", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c682a90caed63c5891144137df7f44e276b2ce98a5906c570f3214b6b6911a949dc44671da70a1df13c15a6f4cad4ea520e18b0a8ac40b06f2b45e52aa2f51", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebef5290cdddb60dbaf189ac3b025ea81c5b9733130467254fe50d60783b296a6c39c35676be13a4910cc745a1926f9c92a713900dccd22388a23ba30e565db8"} 17:06:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:06:07 INFO - Copying logs to upload dir... 17:06:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:06:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.908766 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-27 17:06:07.884423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:06:07.888406) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 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/237d449c5e0b8d811d46fcb30e6e4d5a5583ec8d433e16e4e1ebc81b4e8ccebb28be1c679bd18eb737e17ca84e2d567733f96aa2e819324c7a7204db89f1ed84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4208516cebbdea853e231fc40279efbd9a2f768cae3ab3a015bc728961802de416c8e0832abe43043fbb90732b549c0c980c8b69857e4593bf9ddda78362424", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c682a90caed63c5891144137df7f44e276b2ce98a5906c570f3214b6b6911a949dc44671da70a1df13c15a6f4cad4ea520e18b0a8ac40b06f2b45e52aa2f51", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebef5290cdddb60dbaf189ac3b025ea81c5b9733130467254fe50d60783b296a6c39c35676be13a4910cc745a1926f9c92a713900dccd22388a23ba30e565db8"} build_url:https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237d449c5e0b8d811d46fcb30e6e4d5a5583ec8d433e16e4e1ebc81b4e8ccebb28be1c679bd18eb737e17ca84e2d567733f96aa2e819324c7a7204db89f1ed84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4208516cebbdea853e231fc40279efbd9a2f768cae3ab3a015bc728961802de416c8e0832abe43043fbb90732b549c0c980c8b69857e4593bf9ddda78362424", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76c682a90caed63c5891144137df7f44e276b2ce98a5906c570f3214b6b6911a949dc44671da70a1df13c15a6f4cad4ea520e18b0a8ac40b06f2b45e52aa2f51", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebef5290cdddb60dbaf189ac3b025ea81c5b9733130467254fe50d60783b296a6c39c35676be13a4910cc745a1926f9c92a713900dccd22388a23ba30e565db8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:06:07.924014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:06:07.924722) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506555918.681044-492989850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:06:08.008949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:06:08.009460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:06:08.010008) ========= ========= Total master_lag: 0.21 =========