builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1504893802.96 results: success (0) revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.965126) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.965701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.965991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.013542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.013925) ========= 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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 11:03:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-09-08 11:03:23 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.175158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.175532) ========= 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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.225259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 11:03:23.225576) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 11:03:23,280 truncating revision to first 12 chars 2017-09-08 11:03:23,280 Setting DEBUG logging. 2017-09-08 11:03:23,280 attempt 1/10 2017-09-08 11:03:23,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d0288c29165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 11:03:24,842 unpacking tar archive at: mozilla-central-6d0288c29165/testing/mozharness/ program finished with exit code 0 elapsedTime=1.891712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 11:03:25.135198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:25.135557) ========= script_repo_revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:25.135977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:25.136260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:25.151004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-08 11:03:25.151644) ========= /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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:25 INFO - MultiFileLogger online at 20170908 11:03:25 in /builds/slave/test 11:03:25 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 11:03:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:25 INFO - {'append_to_log': False, 11:03:25 INFO - 'base_work_dir': '/builds/slave/test', 11:03:25 INFO - 'blob_upload_branch': 'Firefox', 11:03:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:25 INFO - 'branch': 'Firefox', 11:03:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:25 INFO - 'code_coverage': False, 11:03:25 INFO - 'config_files': ('talos/linux_config.py',), 11:03:25 INFO - 'default_actions': ('clobber', 11:03:25 INFO - 'read-buildbot-config', 11:03:25 INFO - 'download-and-extract', 11:03:25 INFO - 'populate-webroot', 11:03:25 INFO - 'create-virtualenv', 11:03:25 INFO - 'install', 11:03:25 INFO - 'setup-mitmproxy', 11:03:25 INFO - 'run-tests'), 11:03:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:25 INFO - 'disable_ccov_upload': False, 11:03:25 INFO - 'disable_stylo': False, 11:03:25 INFO - 'download_minidump_stackwalk': True, 11:03:25 INFO - 'download_symbols': 'ondemand', 11:03:25 INFO - 'enable_stylo': False, 11:03:25 INFO - 'enable_webrender': False, 11:03:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:25 INFO - 'gecko_profile': False, 11:03:25 INFO - 'gecko_profile_interval': 0, 11:03:25 INFO - 'installer_path': 'installer.exe', 11:03:25 INFO - 'log_level': 'info', 11:03:25 INFO - 'log_name': 'talos', 11:03:25 INFO - 'log_to_console': True, 11:03:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:25 INFO - 'opt_config_files': (), 11:03:25 INFO - 'pip_index': False, 11:03:25 INFO - 'suite': 'dromaeojs-e10s', 11:03:25 INFO - 'system_bits': '32', 11:03:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:25 INFO - 'title': 'talos-linux64-ix-030', 11:03:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:25 INFO - 'use_talos_json': True, 11:03:25 INFO - 'verify': 'False', 11:03:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:25 INFO - 'work_dir': 'build'} 11:03:25 INFO - [mozharness: 2017-09-08 18:03:25.348109Z] Running clobber step. 11:03:25 INFO - Running pre-action listener: _resource_record_pre_action 11:03:25 INFO - Running main action method: clobber 11:03:25 INFO - rmtree: /builds/slave/test/build 11:03:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:26 INFO - Running post-action listener: _resource_record_post_action 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.358049Z] Finished clobber step (success) 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.358146Z] Running read-buildbot-config step. 11:03:26 INFO - Running pre-action listener: _resource_record_pre_action 11:03:26 INFO - Running main action method: read_buildbot_config 11:03:26 INFO - Using buildbot properties: 11:03:26 INFO - { 11:03:26 INFO - "project": "", 11:03:26 INFO - "product": "firefox", 11:03:26 INFO - "who": "ffxbld@noreply.mozilla.org", 11:03:26 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:03:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:03:26 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:03:26 INFO - "stage_platform": "linux64-qr", 11:03:26 INFO - "basedir": "/builds/slave/test", 11:03:26 INFO - "buildnumber": 38, 11:03:26 INFO - "platform": "ubuntu64_hw_qr", 11:03:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:26 INFO - "slavebuilddir": "test", 11:03:26 INFO - "taskId": "d-Y5Y317Q0e8okR9BdmTOw", 11:03:26 INFO - "branch": "mozilla-central", 11:03:26 INFO - "script_repo_revision": "production", 11:03:26 INFO - "revision": "6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b", 11:03:26 INFO - "slavename": "talos-linux64-ix-030", 11:03:26 INFO - "repo_path": "mozilla-central" 11:03:26 INFO - } 11:03:26 INFO - Finding installer, test and symbols from parent task. 11:03:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-Y5Y317Q0e8okR9BdmTOw'}, attempt #1 11:03:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-Y5Y317Q0e8okR9BdmTOw'}, attempt #1 11:03:27 INFO - Task dependencies: RlzMfz8tRFW8DsiiCEg_WA 11:03:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA'}, attempt #1 11:03:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip 11:03:27 INFO - Running post-action listener: _resource_record_post_action 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.711407Z] Finished read-buildbot-config step (success) 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.711624Z] Running download-and-extract step. 11:03:27 INFO - Running pre-action listener: _resource_record_pre_action 11:03:27 INFO - Running main action method: download_and_extract 11:03:27 INFO - mkdir: /builds/slave/test/build/tests 11:03:27 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')]} 11:03:27 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:27 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:28 INFO - Downloaded 989 bytes. 11:03:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:28 INFO - Using the following test package requirements: 11:03:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:28 INFO - u'common': [u'target.common.tests.zip'], 11:03:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:28 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:28 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:28 INFO - u'target.web-platform.tests.tar.gz'], 11:03:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip 11:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip into memory 11:03:30 INFO - Content-Length response header: 55023640 11:03:30 INFO - Bytes received: 55023640 11:03:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip 11:03:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:40 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip into memory 11:03:41 INFO - Content-Length response header: 14496665 11:03:41 INFO - Bytes received: 14496665 11:03:41 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')]} 11:03:41 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:41 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:43 INFO - Downloaded 62833296 bytes. 11:03:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:43 INFO - mkdir: /builds/slave/test/properties 11:03:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:43 INFO - Contents: 11:03:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:43 INFO - Running post-action listener: _resource_record_post_action 11:03:43 INFO - Running post-action listener: find_tests_for_verification 11:03:43 INFO - Running post-action listener: set_extra_try_arguments 11:03:43 INFO - [mozharness: 2017-09-08 18:03:43.629363Z] Finished download-and-extract step (success) 11:03:43 INFO - [mozharness: 2017-09-08 18:03:43.629460Z] Running populate-webroot step. 11:03:43 INFO - Running pre-action listener: _resource_record_pre_action 11:03:43 INFO - Running main action method: populate_webroot 11:03:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['tresize', 11:03:43 INFO - 'tcanvasmark']}, 11:03:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['dromaeo_css', 11:03:43 INFO - 'kraken']}, 11:03:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'tests': ['damp', 'tps']}, 11:03:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['damp', 'tps']}, 11:03:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['dromaeo_dom']}, 11:03:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['basic_compositor_video', 11:03:43 INFO - 'glvideo']}, 11:03:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['ts_paint_webext', 11:03:43 INFO - 'tp5o_webext']}, 11:03:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:43 INFO - 'ts_paint', 11:03:43 INFO - 'tpaint', 11:03:43 INFO - 'sessionrestore', 11:03:43 INFO - 'sessionrestore_many_windows', 11:03:43 INFO - 'sessionrestore_no_auto_restore', 11:03:43 INFO - 'tabpaint']}, 11:03:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['a11yr', 11:03:43 INFO - 'ts_paint', 11:03:43 INFO - 'tpaint', 11:03:43 INFO - 'sessionrestore', 11:03:43 INFO - 'sessionrestore_many_windows', 11:03:43 INFO - 'sessionrestore_no_auto_restore', 11:03:43 INFO - 'tabpaint']}, 11:03:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:03:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['bloom_basic_singleton']}, 11:03:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['bloom_basic']}, 11:03:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:43 INFO - 'tsvgr_opacity', 11:03:43 INFO - 'tart', 11:03:43 INFO - 'tscrollx', 11:03:43 INFO - 'tsvg_static']}, 11:03:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['tsvgx', 11:03:43 INFO - 'tsvgr_opacity', 11:03:43 INFO - 'tart', 11:03:43 INFO - 'tscrollx', 11:03:43 INFO - 'tsvg_static']}, 11:03:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo'], 11:03:43 INFO - 'tests': ['tp5o']}, 11:03:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:43 INFO - 'talos_options': ['--mitmproxy', 11:03:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:43 INFO - '--firstNonBlankPaint'], 11:03:43 INFO - 'tests': ['tp6_google', 11:03:43 INFO - 'tp6_youtube', 11:03:43 INFO - 'tp6_amazon', 11:03:43 INFO - 'tp6_facebook']}, 11:03:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo', 11:03:43 INFO - '--mitmproxy', 11:03:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:43 INFO - '--firstNonBlankPaint'], 11:03:43 INFO - 'tests': ['tp6_google', 11:03:43 INFO - 'tp6_youtube', 11:03:43 INFO - 'tp6_amazon', 11:03:43 INFO - 'tp6_facebook']}, 11:03:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:43 INFO - 'talos_options': ['--stylo-threads=1', 11:03:43 INFO - '--mitmproxy', 11:03:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:43 INFO - '--firstNonBlankPaint'], 11:03:43 INFO - 'tests': ['tp6_google', 11:03:43 INFO - 'tp6_youtube', 11:03:43 INFO - 'tp6_amazon', 11:03:43 INFO - 'tp6_facebook']}, 11:03:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--xperf_path', 11:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:43 INFO - 'tests': ['tp5n']}, 11:03:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:43 INFO - 'talos_options': ['--disable-stylo', 11:03:43 INFO - '--xperf_path', 11:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:43 INFO - 'tests': ['tp5n']}}} 11:03:43 INFO - Running post-action listener: _resource_record_post_action 11:03:43 INFO - [mozharness: 2017-09-08 18:03:43.644346Z] Finished populate-webroot step (success) 11:03:43 INFO - [mozharness: 2017-09-08 18:03:43.644435Z] Running create-virtualenv step. 11:03:43 INFO - Running pre-action listener: _resource_record_pre_action 11:03:43 INFO - Running main action method: create_virtualenv 11:03:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:03:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:44 INFO - Installing pip...............done. 11:03:44 INFO - Return code: 0 11:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:44 INFO - Reading from file tmpfile_stdout 11:03:44 INFO - Output received: 11:03:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:03:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:44 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')]} 11:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:44 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')]} 11:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:44 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:44 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 11:03:44 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 11:03:44 INFO - Using env: {'DISPLAY': ':0', 11:03:44 INFO - 'HOME': '/home/cltbld', 11:03:44 INFO - 'LANG': 'en_US.UTF-8', 11:03:44 INFO - 'LANGUAGE': 'en_US:en', 11:03:44 INFO - 'LOGNAME': 'cltbld', 11:03:44 INFO - 'MAIL': '/var/mail/cltbld', 11:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:44 INFO - 'MOZ_NO_REMOTE': '1', 11:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:44 INFO - 'NO_EM_RESTART': '1', 11:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:44 INFO - 'PWD': '/builds/slave/test', 11:03:44 INFO - 'SHELL': '/bin/bash', 11:03:44 INFO - 'SHLVL': '1', 11:03:44 INFO - 'TERM': 'linux', 11:03:44 INFO - 'TMOUT': '86400', 11:03:44 INFO - 'USER': 'cltbld', 11:03:44 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:44 INFO - '_': '/tools/buildbot/bin/python'} 11:03:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:03:45 INFO - Downloading/unpacking pip>=1.5 11:03:45 INFO - Running setup.py egg_info for package pip 11:03:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:45 INFO - Installing collected packages: pip 11:03:45 INFO - Found existing installation: pip 1.1 11:03:45 INFO - Uninstalling pip: 11:03:45 INFO - Successfully uninstalled pip 11:03:45 INFO - Running setup.py install for pip 11:03:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:03:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:03:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:03:45 INFO - Successfully installed pip 11:03:45 INFO - Cleaning up... 11:03:45 INFO - Return code: 0 11:03:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03: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', '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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:03: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 psutil>=3.1.1 11:03:45 INFO - Using env: {'DISPLAY': ':0', 11:03:45 INFO - 'HOME': '/home/cltbld', 11:03:45 INFO - 'LANG': 'en_US.UTF-8', 11:03:45 INFO - 'LANGUAGE': 'en_US:en', 11:03:45 INFO - 'LOGNAME': 'cltbld', 11:03:45 INFO - 'MAIL': '/var/mail/cltbld', 11:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:45 INFO - 'MOZ_NO_REMOTE': '1', 11:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:45 INFO - 'NO_EM_RESTART': '1', 11:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:45 INFO - 'PWD': '/builds/slave/test', 11:03:45 INFO - 'SHELL': '/bin/bash', 11:03:45 INFO - 'SHLVL': '1', 11:03:45 INFO - 'TERM': 'linux', 11:03:45 INFO - 'TMOUT': '86400', 11:03:45 INFO - 'USER': 'cltbld', 11:03:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:45 INFO - '_': '/tools/buildbot/bin/python'} 11:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:46 INFO - Downloading/unpacking psutil>=3.1.1 11:03: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 11:03: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 11:03: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 11:03: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 11:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:47 INFO - Installing collected packages: psutil 11:03:47 INFO - Running setup.py install for psutil 11:03:47 INFO - building 'psutil._psutil_linux' extension 11:03:47 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 11:03:47 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 11:03:47 INFO - building 'psutil._psutil_posix' extension 11:03:47 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 11:03:47 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 11:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:47 INFO - Successfully installed psutil 11:03:47 INFO - Cleaning up... 11:03:47 INFO - Return code: 0 11:03:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:03: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 mozsystemmonitor==0.3 11:03:47 INFO - Using env: {'DISPLAY': ':0', 11:03:47 INFO - 'HOME': '/home/cltbld', 11:03:47 INFO - 'LANG': 'en_US.UTF-8', 11:03:47 INFO - 'LANGUAGE': 'en_US:en', 11:03:47 INFO - 'LOGNAME': 'cltbld', 11:03:47 INFO - 'MAIL': '/var/mail/cltbld', 11:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:47 INFO - 'MOZ_NO_REMOTE': '1', 11:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:47 INFO - 'NO_EM_RESTART': '1', 11:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:47 INFO - 'PWD': '/builds/slave/test', 11:03:47 INFO - 'SHELL': '/bin/bash', 11:03:47 INFO - 'SHLVL': '1', 11:03:47 INFO - 'TERM': 'linux', 11:03:47 INFO - 'TMOUT': '86400', 11:03:47 INFO - 'USER': 'cltbld', 11:03:47 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:47 INFO - '_': '/tools/buildbot/bin/python'} 11:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03: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 11:03: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 11:03: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 11:03: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 11:03:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:49 INFO - Installing collected packages: mozsystemmonitor 11:03:49 INFO - Running setup.py install for mozsystemmonitor 11:03:49 INFO - Successfully installed mozsystemmonitor 11:03:49 INFO - Cleaning up... 11:03:49 INFO - Return code: 0 11:03:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:49 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:49 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 11:03:49 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 11:03:49 INFO - Using env: {'DISPLAY': ':0', 11:03:49 INFO - 'HOME': '/home/cltbld', 11:03:49 INFO - 'LANG': 'en_US.UTF-8', 11:03:49 INFO - 'LANGUAGE': 'en_US:en', 11:03:49 INFO - 'LOGNAME': 'cltbld', 11:03:49 INFO - 'MAIL': '/var/mail/cltbld', 11:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:49 INFO - 'MOZ_NO_REMOTE': '1', 11:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:49 INFO - 'NO_EM_RESTART': '1', 11:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:49 INFO - 'PWD': '/builds/slave/test', 11:03:49 INFO - 'SHELL': '/bin/bash', 11:03:49 INFO - 'SHLVL': '1', 11:03:49 INFO - 'TERM': 'linux', 11:03:49 INFO - 'TMOUT': '86400', 11:03:49 INFO - 'USER': 'cltbld', 11:03:49 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:49 INFO - '_': '/tools/buildbot/bin/python'} 11:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:49 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:49 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 11:03:49 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 11:03:49 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 11:03:49 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 11:03:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:51 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 11:03:51 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 11:03:51 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 11:03:51 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 11:03:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:51 INFO - warning: no files found matching '*.txt' 11:03:51 INFO - no previously-included directories found matching 'build' 11:03:51 INFO - no previously-included directories found matching 'dist' 11:03:51 INFO - no previously-included directories found matching '.git*' 11:03:51 INFO - Installing collected packages: jsonschema, functools32 11:03:51 INFO - Running setup.py install for functools32 11:03:51 INFO - warning: no files found matching '*.txt' 11:03:51 INFO - no previously-included directories found matching 'build' 11:03:51 INFO - no previously-included directories found matching 'dist' 11:03:51 INFO - no previously-included directories found matching '.git*' 11:03:51 INFO - Successfully installed jsonschema functools32 11:03:51 INFO - Cleaning up... 11:03:51 INFO - Return code: 0 11:03:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:03:51 INFO - Using env: {'DISPLAY': ':0', 11:03:51 INFO - 'HOME': '/home/cltbld', 11:03:51 INFO - 'LANG': 'en_US.UTF-8', 11:03:51 INFO - 'LANGUAGE': 'en_US:en', 11:03:51 INFO - 'LOGNAME': 'cltbld', 11:03:51 INFO - 'MAIL': '/var/mail/cltbld', 11:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:51 INFO - 'MOZ_NO_REMOTE': '1', 11:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:51 INFO - 'NO_EM_RESTART': '1', 11:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:51 INFO - 'PWD': '/builds/slave/test', 11:03:51 INFO - 'SHELL': '/bin/bash', 11:03:51 INFO - 'SHLVL': '1', 11:03:51 INFO - 'TERM': 'linux', 11:03:51 INFO - 'TMOUT': '86400', 11:03:51 INFO - 'USER': 'cltbld', 11:03:51 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:51 INFO - '_': '/tools/buildbot/bin/python'} 11:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:51 INFO - Cleaning up... 11:03:51 INFO - Return code: 0 11:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:51 INFO - Using env: {'DISPLAY': ':0', 11:03:51 INFO - 'HOME': '/home/cltbld', 11:03:51 INFO - 'LANG': 'en_US.UTF-8', 11:03:51 INFO - 'LANGUAGE': 'en_US:en', 11:03:51 INFO - 'LOGNAME': 'cltbld', 11:03:51 INFO - 'MAIL': '/var/mail/cltbld', 11:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:51 INFO - 'MOZ_NO_REMOTE': '1', 11:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:51 INFO - 'NO_EM_RESTART': '1', 11:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:51 INFO - 'PWD': '/builds/slave/test', 11:03:51 INFO - 'SHELL': '/bin/bash', 11:03:51 INFO - 'SHLVL': '1', 11:03:51 INFO - 'TERM': 'linux', 11:03:51 INFO - 'TMOUT': '86400', 11:03:51 INFO - 'USER': 'cltbld', 11:03:51 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:51 INFO - '_': '/tools/buildbot/bin/python'} 11:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - Downloading docopt-0.6.1.tar.gz 11:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:53 INFO - Running setup.py install for blobuploader 11:03:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:53 INFO - Running setup.py install for requests 11:03:54 INFO - Running setup.py install for docopt 11:03:54 INFO - Successfully installed blobuploader requests docopt 11:03:54 INFO - Cleaning up... 11:03:54 INFO - Return code: 0 11:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:54 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:54 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 11:03:54 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 11:03:54 INFO - Using env: {'DISPLAY': ':0', 11:03:54 INFO - 'HOME': '/home/cltbld', 11:03:54 INFO - 'LANG': 'en_US.UTF-8', 11:03:54 INFO - 'LANGUAGE': 'en_US:en', 11:03:54 INFO - 'LOGNAME': 'cltbld', 11:03:54 INFO - 'MAIL': '/var/mail/cltbld', 11:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:54 INFO - 'MOZ_NO_REMOTE': '1', 11:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:54 INFO - 'NO_EM_RESTART': '1', 11:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:54 INFO - 'PWD': '/builds/slave/test', 11:03:54 INFO - 'SHELL': '/bin/bash', 11:03:54 INFO - 'SHLVL': '1', 11:03:54 INFO - 'TERM': 'linux', 11:03:54 INFO - 'TMOUT': '86400', 11:03:54 INFO - 'USER': 'cltbld', 11:03:54 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:54 INFO - '_': '/tools/buildbot/bin/python'} 11:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:54 INFO - Running setup.py (path:/tmp/pip-hvwzX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:54 INFO - Running setup.py (path:/tmp/pip-p1SvHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:54 INFO - Running setup.py (path:/tmp/pip-Dp60V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:54 INFO - Running setup.py (path:/tmp/pip-ftkuzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:54 INFO - Running setup.py (path:/tmp/pip-spTRwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:54 INFO - Running setup.py (path:/tmp/pip-oy62bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:54 INFO - Running setup.py (path:/tmp/pip-0pzZJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:55 INFO - Running setup.py (path:/tmp/pip-P_zOrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:55 INFO - Running setup.py (path:/tmp/pip-fHOuHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:55 INFO - Running setup.py (path:/tmp/pip-I19RVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:55 INFO - Running setup.py (path:/tmp/pip-Y4ED9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:55 INFO - Running setup.py (path:/tmp/pip-oRtiDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:55 INFO - Running setup.py (path:/tmp/pip-qiGdTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:55 INFO - Running setup.py (path:/tmp/pip-7MN9_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:55 INFO - Running setup.py (path:/tmp/pip-9Er8uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:55 INFO - Running setup.py (path:/tmp/pip-IHQExd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:55 INFO - Running setup.py (path:/tmp/pip-4jsDLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:55 INFO - Running setup.py install for manifestparser 11:03:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozcrash 11:03:55 INFO - Running setup.py install for mozdebug 11:03:56 INFO - Running setup.py install for mozdevice 11:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozfile 11:03:56 INFO - Running setup.py install for mozhttpd 11:03:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozinfo 11:03:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozInstall 11:03:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozleak 11:03:56 INFO - Running setup.py install for mozlog 11:03:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for moznetwork 11:03:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozprocess 11:03:56 INFO - Running setup.py install for mozprofile 11:03:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozrunner 11:03:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozscreenshot 11:03:57 INFO - Running setup.py install for moztest 11:03:57 INFO - Running setup.py install for mozversion 11:03:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:57 INFO - Cleaning up... 11:03:57 INFO - Return code: 0 11:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:57 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:03:57 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 11:03:57 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 11:03:57 INFO - Using env: {'DISPLAY': ':0', 11:03:57 INFO - 'HOME': '/home/cltbld', 11:03:57 INFO - 'LANG': 'en_US.UTF-8', 11:03:57 INFO - 'LANGUAGE': 'en_US:en', 11:03:57 INFO - 'LOGNAME': 'cltbld', 11:03:57 INFO - 'MAIL': '/var/mail/cltbld', 11:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:57 INFO - 'MOZ_NO_REMOTE': '1', 11:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:57 INFO - 'NO_EM_RESTART': '1', 11:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:57 INFO - 'PWD': '/builds/slave/test', 11:03:57 INFO - 'SHELL': '/bin/bash', 11:03:57 INFO - 'SHLVL': '1', 11:03:57 INFO - 'TERM': 'linux', 11:03:57 INFO - 'TMOUT': '86400', 11:03:57 INFO - 'USER': 'cltbld', 11:03:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:57 INFO - '_': '/tools/buildbot/bin/python'} 11:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:57 INFO - Running setup.py (path:/tmp/pip-boSicC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:57 INFO - Running setup.py (path:/tmp/pip-kCnT3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:57 INFO - Running setup.py (path:/tmp/pip-B0bZ_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:57 INFO - Running setup.py (path:/tmp/pip-LO3aIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:57 INFO - Running setup.py (path:/tmp/pip-iHJH9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:58 INFO - Running setup.py (path:/tmp/pip-lk6clL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:58 INFO - Running setup.py (path:/tmp/pip-7vdo5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:58 INFO - Running setup.py (path:/tmp/pip-382Ukm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:58 INFO - Running setup.py (path:/tmp/pip-IE3dqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:58 INFO - Running setup.py (path:/tmp/pip-X4G_ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:58 INFO - Running setup.py (path:/tmp/pip-B2_MMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:58 INFO - Running setup.py (path:/tmp/pip-sQD8bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:58 INFO - Running setup.py (path:/tmp/pip-T8NGNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:58 INFO - Running setup.py (path:/tmp/pip-YE2wT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:58 INFO - Running setup.py (path:/tmp/pip-bSv3jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:58 INFO - Running setup.py (path:/tmp/pip-5ElMbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:58 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)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:58 INFO - Running setup.py (path:/tmp/pip-MWcUxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:58 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)) 11:03:58 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)) 11:03:58 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)) 11:03:58 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)) 11:03:58 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)) 11:03:58 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)) 11:03:58 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)) 11:03:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:00 INFO - Downloading blessings-1.6.tar.gz 11:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:04:00 INFO - Installing collected packages: blessings 11:04:00 INFO - Running setup.py install for blessings 11:04:00 INFO - Successfully installed blessings 11:04:00 INFO - Cleaning up... 11:04:00 INFO - Return code: 0 11:04:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:00 INFO - Reading from file tmpfile_stdout 11:04:00 INFO - Current package versions: 11:04:00 INFO - argparse == 1.2.1 11:04:00 INFO - blessings == 1.6 11:04:00 INFO - blobuploader == 1.2.4 11:04:00 INFO - docopt == 0.6.1 11:04:00 INFO - functools32 == 3.2.3-2 11:04:00 INFO - jsonschema == 2.5.1 11:04:00 INFO - manifestparser == 1.1 11:04:00 INFO - mozInstall == 1.13 11:04:00 INFO - mozcrash == 1.0 11:04:00 INFO - mozdebug == 0.1 11:04:00 INFO - mozdevice == 0.51 11:04:00 INFO - mozfile == 1.2 11:04:00 INFO - mozhttpd == 0.7 11:04:00 INFO - mozinfo == 0.10 11:04:00 INFO - mozleak == 0.1 11:04:00 INFO - mozlog == 3.5 11:04:00 INFO - moznetwork == 0.27 11:04:00 INFO - mozprocess == 0.25 11:04:00 INFO - mozprofile == 0.28 11:04:00 INFO - mozrunner == 6.13 11:04:00 INFO - mozscreenshot == 0.1 11:04:00 INFO - mozsystemmonitor == 0.3 11:04:00 INFO - moztest == 0.8 11:04:00 INFO - mozversion == 1.4 11:04:00 INFO - psutil == 3.1.1 11:04:00 INFO - requests == 1.2.3 11:04:00 INFO - wsgiref == 0.1.2 11:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:00 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:04:00 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 11:04:00 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 11:04:00 INFO - Using env: {'DISPLAY': ':0', 11:04:00 INFO - 'HOME': '/home/cltbld', 11:04:00 INFO - 'LANG': 'en_US.UTF-8', 11:04:00 INFO - 'LANGUAGE': 'en_US:en', 11:04:00 INFO - 'LOGNAME': 'cltbld', 11:04:00 INFO - 'MAIL': '/var/mail/cltbld', 11:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:00 INFO - 'MOZ_NO_REMOTE': '1', 11:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:00 INFO - 'NO_EM_RESTART': '1', 11:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:00 INFO - 'PWD': '/builds/slave/test', 11:04:00 INFO - 'SHELL': '/bin/bash', 11:04:00 INFO - 'SHLVL': '1', 11:04:00 INFO - 'TERM': 'linux', 11:04:00 INFO - 'TMOUT': '86400', 11:04:00 INFO - 'USER': 'cltbld', 11:04:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:00 INFO - '_': '/tools/buildbot/bin/python'} 11:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:04:01 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)) 11:04:01 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)) 11:04:01 INFO - Installing collected packages: simplejson 11:04:01 INFO - Running setup.py install for simplejson 11:04:01 INFO - building 'simplejson._speedups' extension 11:04:01 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 11:04:02 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 11:04:02 INFO - Successfully installed simplejson 11:04:02 INFO - Cleaning up... 11:04:02 INFO - Return code: 0 11:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:02 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 0x1c031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, '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': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', '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 11:04:02 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 11:04:02 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 11:04:02 INFO - Using env: {'DISPLAY': ':0', 11:04:02 INFO - 'HOME': '/home/cltbld', 11:04:02 INFO - 'LANG': 'en_US.UTF-8', 11:04:02 INFO - 'LANGUAGE': 'en_US:en', 11:04:02 INFO - 'LOGNAME': 'cltbld', 11:04:02 INFO - 'MAIL': '/var/mail/cltbld', 11:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:02 INFO - 'MOZ_NO_REMOTE': '1', 11:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:02 INFO - 'NO_EM_RESTART': '1', 11:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:02 INFO - 'PWD': '/builds/slave/test', 11:04:02 INFO - 'SHELL': '/bin/bash', 11:04:02 INFO - 'SHLVL': '1', 11:04:02 INFO - 'TERM': 'linux', 11:04:02 INFO - 'TMOUT': '86400', 11:04:02 INFO - 'USER': 'cltbld', 11:04:02 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:02 INFO - '_': '/tools/buildbot/bin/python'} 11:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:03 INFO - Cleaning up... 11:04:03 INFO - Return code: 0 11:04:03 INFO - Running post-action listener: _resource_record_post_action 11:04:03 INFO - Running post-action listener: _start_resource_monitoring 11:04:03 INFO - Starting resource monitoring. 11:04:03 INFO - [mozharness: 2017-09-08 18:04:03.160579Z] Finished create-virtualenv step (success) 11:04:03 INFO - [mozharness: 2017-09-08 18:04:03.161099Z] Running install step. 11:04:03 INFO - Running pre-action listener: _resource_record_pre_action 11:04:03 INFO - Running main action method: install 11:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:03 INFO - Reading from file tmpfile_stdout 11:04:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:03 INFO - Reading from file tmpfile_stdout 11:04:03 INFO - Output received: 11:04:03 INFO - Usage: mozinstall [options] installer 11:04:03 INFO - Options: 11:04:03 INFO - -h, --help show this help message and exit 11:04:03 INFO - -d DEST, --destination=DEST 11:04:03 INFO - Directory to install application into. [default: 11:04:03 INFO - "/builds/slave/test"] 11:04:03 INFO - --app=APP Application being installed. [default: firefox] 11:04:03 INFO - mkdir: /builds/slave/test/build/application 11:04:03 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'] 11:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:20 INFO - Reading from file tmpfile_stdout 11:04:20 INFO - Output received: 11:04:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:20 INFO - Running post-action listener: _resource_record_post_action 11:04:20 INFO - [mozharness: 2017-09-08 18:04:20.041033Z] Finished install step (success) 11:04:20 INFO - [mozharness: 2017-09-08 18:04:20.041377Z] Running setup-mitmproxy step. 11:04:20 INFO - Running pre-action listener: _resource_record_pre_action 11:04:20 INFO - Running main action method: setup_mitmproxy 11:04:20 INFO - Skipping: mitmproxy is not required 11:04:20 INFO - Running post-action listener: _resource_record_post_action 11:04:20 INFO - [mozharness: 2017-09-08 18:04:20.043092Z] Finished setup-mitmproxy step (success) 11:04:20 INFO - [mozharness: 2017-09-08 18:04:20.043405Z] Running run-tests step. 11:04:20 INFO - Running pre-action listener: _resource_record_pre_action 11:04:20 INFO - Running pre-action listener: _set_gcov_prefix 11:04:20 INFO - Running main action method: run_tests 11:04:20 WARNING - Try message not found. 11:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:20 INFO - Python 2.7.3 11:04:20 INFO - Return code: 0 11:04:20 INFO - grabbing minidump binary from tooltool 11:04:20 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')]} 11:04:20 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 0x1f73090>, '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 0x1f73d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:20 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 11:04:20 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 11:04:20 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 11:04:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:20 INFO - Return code: 0 11:04:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:20 INFO - ENV: RUST_BACKTRACE is now full 11:04:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:20 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:04:20 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 11:04:20 INFO - Using env: {'DISPLAY': ':0', 11:04:20 INFO - 'HOME': '/home/cltbld', 11:04:20 INFO - 'LANG': 'en_US.UTF-8', 11:04:20 INFO - 'LANGUAGE': 'en_US:en', 11:04:20 INFO - 'LOGNAME': 'cltbld', 11:04:20 INFO - 'MAIL': '/var/mail/cltbld', 11:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:20 INFO - 'MOZ_ACCELERATED': '1', 11:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:20 INFO - 'MOZ_NO_REMOTE': '1', 11:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:20 INFO - 'MOZ_WEBRENDER': '1', 11:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:20 INFO - 'NO_EM_RESTART': '1', 11:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:20 INFO - 'PWD': '/builds/slave/test', 11:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:20 INFO - 'RUST_BACKTRACE': 'full', 11:04:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:20 INFO - 'SHELL': '/bin/bash', 11:04:20 INFO - 'SHLVL': '1', 11:04:20 INFO - 'TERM': 'linux', 11:04:20 INFO - 'TMOUT': '86400', 11:04:20 INFO - 'USER': 'cltbld', 11:04:20 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:20 INFO - '_': '/tools/buildbot/bin/python'} 11:04:20 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:04:20 INFO - mozversion application_buildid: 20170908171740 11:04:20 INFO - mozversion application_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:20 INFO - mozversion application_display_name: Nightly 11:04:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:20 INFO - mozversion application_name: Firefox 11:04:20 INFO - mozversion application_remotingname: firefox 11:04:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:04:20 INFO - mozversion application_vendor: Mozilla 11:04:20 INFO - mozversion application_version: 57.0a1 11:04:20 INFO - mozversion platform_buildid: 20170908171740 11:04:20 INFO - mozversion platform_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:04:20 INFO - mozversion platform_version: 57.0a1 11:04:20 INFO - using testdate: 1504893860 11:04:20 INFO - actual date: 1504893860 11:04:20 INFO - starting webserver on 'localhost:54860' 11:04:20 INFO - SUITE-START | Running 2 tests 11:04:20 INFO - TEST-START | dromaeo_css 11:04:20 INFO - Initialising browser for dromaeo_css test... 11:04:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54860/getInfo.html -profile /tmp/tmpNE2XFH/profile 11:04:20 INFO - TEST-INFO | started process 24399 (/builds/slave/test/build/application/firefox/firefox http://localhost:54860/getInfo.html) 11:04:27 INFO - TEST-INFO | 24399: exit 0 11:04:27 INFO - Browser initialized. 11:04:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:27 INFO - Using env: {'DISPLAY': ':0', 11:04:27 INFO - 'HOME': '/home/cltbld', 11:04:27 INFO - 'JSGC_DISABLE_POISONING': '1', 11:04:27 INFO - 'LANG': 'en_US.UTF-8', 11:04:27 INFO - 'LANGUAGE': 'en_US:en', 11:04:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:04:27 INFO - 'LOGNAME': 'cltbld', 11:04:27 INFO - 'MAIL': '/var/mail/cltbld', 11:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:27 INFO - 'MOZ_ACCELERATED': '1', 11:04:27 INFO - 'MOZ_CRASHREPORTER': '1', 11:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:04:27 INFO - 'MOZ_NO_REMOTE': '1', 11:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:27 INFO - 'MOZ_WEBRENDER': '1', 11:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:27 INFO - 'NO_EM_RESTART': '1', 11:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:27 INFO - 'PWD': '/builds/slave/test', 11:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:27 INFO - 'RUST_BACKTRACE': 'full', 11:04:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:27 INFO - 'SHELL': '/bin/bash', 11:04:27 INFO - 'SHLVL': '1', 11:04:27 INFO - 'TERM': 'linux', 11:04:27 INFO - 'TMOUT': '86400', 11:04:27 INFO - 'USER': 'cltbld', 11:04:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:27 INFO - '_': '/tools/buildbot/bin/python'} 11:04:27 INFO - TEST-INFO | started process 24609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNE2XFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:28 INFO - PID 24609 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:04:29 INFO - PID 24609 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:04:29 INFO - PID 24609 | 11:04:29 INFO - PID 24609 | (/builds/slave/test/build/application/firefox/firefox:24670): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:29 INFO - PID 24609 | 11:04:39 INFO - PID 24609 | RSS: Main: 211345408 11:04:39 INFO - PID 24609 | 11:07:37 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54860/tests/dromaeo/cssquery-ext.html) 11:07:38 INFO - PID 24609 | RSS: Main: 218238976 11:07:38 INFO - PID 24609 | 11:10:40 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-ext.html (next: http://localhost:54860/tests/dromaeo/cssquery-jquery.html) 11:10:41 INFO - PID 24609 | RSS: Main: 217280512 11:10:41 INFO - PID 24609 | 11:13:43 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54860/tests/dromaeo/cssquery-mootools.html) 11:13:44 INFO - PID 24609 | RSS: Main: 219570176 11:13:44 INFO - PID 24609 | 11:16:46 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54860/tests/dromaeo/cssquery-prototype.html) 11:16:46 INFO - PID 24609 | RSS: Main: 218796032 11:16:46 INFO - PID 24609 | 11:19:50 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54860/tests/dromaeo/cssquery-yui.html) 11:19:50 INFO - PID 24609 | RSS: Main: 219705344 11:19:50 INFO - PID 24609 | 11:22:52 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:54860/tests/dromaeo/cssquery-yui.html (next: http://localhost:54860/tests/dromaeo/cssquery-dojo.html) 11:22:53 INFO - PID 24609 | RSS: Main: 222957568 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | __start_tp_report 11:22:53 INFO - PID 24609 | _x_x_mozilla_page_load 11:22:53 INFO - PID 24609 | _x_x_mozilla_page_load_details 11:22:53 INFO - PID 24609 | |i|pagename|runs| 11:22:53 INFO - PID 24609 | |0;dojo.html;3108.4404807134715;3143.732782713469;3144.9842750786256;3151.6848315168486;3172.254520187756;6171.598846075002;6235.812925612227;6368.777092801753;6372;6386.393292637198;6222;6241.750329986807;6251.156093927319;6289.559730818844;6323.146375239353;5794.971025144879;5813.09896965971;5842.707864606774;5897.823065308026;5934.614250073753;5859.355470898197;5901.05583106703;5942.970285148568;5967.462928336449;5983.58114931955;5666.858328541778;5750.539956803445;5874.00141975863;5883.264591926009;5991.191189189469;5320.737919778441;5818.1272809078555;5863.76544938202;5879.088741245114;5907.409259074101;5787.33445653751;5797.188393624896;5848.824535263949;5850.795222167204;5855.795047173328;6183.628982261079;6183.690815459209;6227.439530442282;6237.844053898643;6257.186565746424;6745.258021617618;6752.1222241108835;6776.525643204977;6803.48973826965;6821.590704557742;6794.796156115324;6797.456203503757;6883.3116688331265;6891.207511136183;6896.7586134485555;6125.96937015321;6254.374562543755;6319.6208227506495;6347.016212487118;6404.647744374058;6835;6893.20728116273;6965.268646792014;7014.92985070153;7024.367806897301;6599.340065993459;6620.470362370998;6634.568753031038;6676.6327851967635;6728.495362847806;6757.898631520531;6798.5241033128195;6812.080369150201;6866.450683945272;6876.346747059021;6509.609423434609;6663.400293973566;6665.633390163491;6668.86662266752;6672.566283191577;6629.469642428594;6657.167854018247;6686.699098540577;6691.0967019451755;6708.597484150967;5189.273501709688;5256.632035757537;5314.70769107695;5316.6544174628525;5324.653897496651;4590.586847183769;4597.586217240398;4677.953220467752;4682.6253899687945;4686.343911852344;5805.535557155417;5878.147668588116;5886.1465087562065;5890;5895.616784908967;6816.113905192294;6817.659117044128;6834.179898412222;6921.550099243533;6923.6192009438955;5642.069058605366;5714.7999820006935;5720.1991721159075;5737.8565535861935;5846;5690.748035432198;5772.480476757112;5836.182934389189;5847.532197424196;5856;6499.252585952676;6509.251436084816;6513.576617519846;6580.374864387875;6592.472602191813;6822.249552549315;6822.931770682229;6832.760853370109;6860.279670634512;6913.170419549686;6519.315471875385;6533.118029066015;6541.411272985264;6620.404163625297;6636.0377745225705;6572.277049524453;6595.637239951849;6690.698918548775;6702.262751097473;6724.193096828412;6801.251862295045;6806.76176333826;6831.795046148424;6850.280720524273;6865.27914568963;6584.670766461562;6596.30738772422;6623.933760662332;6677.632730199885;6678.098456708282;6563.638999855054;6600.53796234259;6644.501662375438;6649.235337936199;6684.966575167093;6315.684215789101;6368.840778980562;6431.807045788634;6457.870842583028;6463.935360646334;6585.275619681927;6604.768833090819;6606.240282367589;6607.636579988147;6661.966690166518;6334.904976425265;6343.080253363329;6353.618782873043;6371.649559274284;6442.8389290268115 11:22:53 INFO - PID 24609 | |1;ext.html;851.7359618518259;866.9653213871445;869.647792643979;871.0766587417341;886.03422269726;38543.80728096363;42156.789216053876;42191.36712949308;42356.152876942484;42377.576224237746;38954.415683764695;39473.60526394735;39498.40752388717;39511.60488395115;39538;7094.751683691059;7170.60561669108;7238.71045158193;7712.5372477651235;7937;7653.081630204383;7791.298783109519;7796.142424333319;7817.843643127134;7823.904653348536;7770.883436748425;7860.724874629389;7861.056673199224;7863.488873223251;7868.52788832669;7691.961540192319;7757.107932587768;7772.183920688303;7799.883001754978;7805.37556995439;7742.225777422269;7746.767596972099;7766.805829854299;7774;7817.257360550795;38410.231795363936;38673.22653546913;38919.41620875689;39004.609953900384;39167;3616.3671357512594;3643.6902863256655;3655.524781778352;3657.5062366580437;3660.5241318628673;31644.208894777585;31717.682823171934;31726.206844828834;31785.364292714017;31826.204344891332;5101.897962040775;5157.638965272433;5194.896102077937;5205.479452054802;5283.9471605284225;187899;189267;189604;189604.99999999863;189885;42201.57798422038;42884.78557607192;47722.52277477181;48062.759686202044;48713.75643121762;51398.22902656463;51672.741636291576;51800;51831.740841296305;51933.48066519287;15801.762973555406;15915.0450972942;15981.680366392608;15993.040417574983;16013.279402426919;13047.804282935764;13130.34348282582;13168.670783230496;13177.47290108404;13188.802167967488;14176.149431034171;14183.858161418253;14217.786733199011;14284.285785710674;14519.491817786327;5700.173474846124;5802.738876750556;5867.589268751147;5904.675242861684;5927;1009.5103874620803;1035.2597892506744;1036.1658864613908;1039.2153923787491;1047.4814966591587;22315.44211394728;22387.97773284425;22498.21256256056;22524.099036038377;22586;1085.9076978456762;1103.194667892443;1115.1803424482998;1118.5917140243914;1131.7114135895295;12113.818292725617;12150;12190.51237950472;12236;12251.14242003069;217556;219201;219764;221651;222247;52666.73666631642;53037.20444193263;53310.200346994825;53357.733211333696;53418.73290633522;1393.171063217384;1446.5154173352046;1455.6288146522782;1462.4223431744401;1464.6777708904024;22081.447963801034;22670.319890402654;22876.4280892979;22881.77118228863;22989.770102299433;34475.31049378948;34490.48264276088;34525.65474345224;34548;34583.82708086444;194446;194502;194520;195149;196380;29786.255343616584;30213.848930755204;31524.842375787975;32982.175445614055;34132.488012679336;41353.58646413618;41997;42299.57700422956;42729.78635106805;42862;31146.221344465663;31343.84328078345;31379.215519612193;31521.054368368987;31553;27837.721622783512;27849.582256265767;27854.44291114207;28199.15402537927;28539.571906421836;35113.47329790004;35126.64873351234;35180.64819351876;35290.470642939865;35337.82331088328;30256.243593910327;30410;30640.387192256476;30683.386332272785;30838.229044273176;22422.663660044786;22908.48678663576;23376.64935025942;23486.177983770485;23526.882365588062 11:22:53 INFO - PID 24609 | |2;jquery.html;554.5702080887312;564.7148190163966;565.3498476751734;577.1775220311056;587.2571197435244;21824.23615173469;22670.88664556677;22723.091076356926;22733.658995115085;22738.88630556849;22797.202097926576;23832.64251036236;24272.15047473339;24279.75720242797;24519.87740061297;6435.420812126896;6528.543001989862;6566.737330506798;6567.967160164192;6573.342665733412;6326.873462530747;6525.771597994071;6541.21505419348;6541.901871471931;6550.672466376686;6159.199304090462;6438.259600145973;6459.838504037413;6465.935340646603;6500.479961603084;6420.711068001951;6520.054592084145;6520.543561950665;6526.706298216592;6529.347065293457;5579.079451890433;5799.652020878719;5801.274840644919;5824.417558244184;6033.607815491979;27541.173764787087;27893.16320510388;28072.017479388327;28125.29686757827;28160;2033.4509682385822;2070.6893965905083;2071.295759441797;2071.326818783886;2072.1297055236837;18258.543536411562;18776.155073021746;18927.716084258747;19169.712454313198;19573.119209635457;2354.376090336062;2399.58007348715;2408.7350391456926;2412.541617092764;2425.7938075263623;122215;127415;136296;143477.2826135873;143866;14099.295035248197;14119.223442710749;14195.290235488184;14378.640533986734;14412.13527188372;22304;22460.55078898413;22477.32568022962;22486.437839053826;22494.887525562266;9843.852342214872;10093.091621754078;10185.236107291983;10327.122194613543;10340.27618066728;9332.206762425134;9378.765530861647;9470.52647367629;9477.763055923657;9565.378250413702;8699.347548933856;8741.256993155654;8954;8987.910120898838;9167.633294668138;2516.848989060662;2552.4257042165364;2626.500964816679;2638.7493188147096;2657.707652158261;931.9068093190626;962.2206013129388;970.4080510888352;973.8928717841031;980.9117179453883;18358.63282734338;18736.250549978122;18961.336353227573;19289.421317360502;19333;1020.9336393134422;1024.3188279793853;1024.8770147582188;1026.3021145621049;1028.5834237133972;10464.581416743396;10528.789424211625;10536.473176341153;10685.412302323446;10776.19178561611;463500;470006;470204;481650;491656;106943;107292.46353768338;110069.44965275122;110345;111621.44189279164;1016.4968340671415;1040.5213601743283;1123.1576317761678;1139.2171251990608;1180.7992641251008;19467;19666.60666786685;20050.498737531678;20119.295824646066;20206.494837629176;54331.45668543264;55804;56562;56575.434245657016;57096.71451642715;68490.65754671195;68944;69930;70136.29863701298;70414.29585704078;19413.8058619412;19579.412617621496;19733.506662333555;19770.50573735668;19863.503412414804;21895.45261368415;22161.88919055459;22312.888435557717;22346;22539.88730056339;17763.20065597077;17925.28298868083;17986.730199047288;18022.5494362642;18160.455186344432;14514.129152250476;14595.416183352547;14604.342804573607;15572.610684732519;15633.921830390775;17782.110894455484;17922.820771792638;17940.730889036935;18065.638687225917;18336;19128.426147215607;19241.326553570558;19323.323683671006;19465.902670486557;19476.513087172934;17433.389831355842;17660.823391765916;17773.200205990503;17923.28306867763;18131.637367252846 11:22:53 INFO - PID 24609 | |3;mootools.html;1316.1773891317926;1379.2276325257853;1386.7781155015193;1401.1102949626998;1401.474447082344;14896.47862324819;15512.922435387807;15519.84480155198;15554.688906221869;15560.37758489659;15217.39130434784;15372.308246128923;15381.23093845306;15405.691886162298;15415;2773.55623100304;2801.5097357962377;2840.6449193850767;2844.772418206549;2863.1983044747503;2708.404151086768;2795.6784969728437;2819.520681484142;2827.406244688618;2832.957505637417;2713.4030513287144;2714.3892624159603;2810.12886005338;2811.8172318799316;2812.8312301261885;2839.886404543816;2841.502737021023;2847.430513897229;2849.487092323381;2862.212891454856;2670.8798104085167;2711.295063283541;2716.5246081935584;2720.2111387697546;2723.1149876290283;14799.556013319618;15192.544223673307;15207.695846083016;15229.390824367123;15268.77096843537;7966.163552826928;8314.41799074065;8358.122397148334;8398.916010839936;8405.075441701469;5361.624686271963;5629.7185140742795;5773.220615216934;5780.826575202751;5808.82573522795;1919.6928491441302;1946.7858535561077;1959.2750682247517;1973.0923775063488;1994.0926878270498;26887.05895293675;27024.324391890164;27053.729462705516;27127.728722712916;27277.318067048283;6741.629210393476;6939.959006149118;7050.259722729143;7089.539179953286;7126.572405655574;17614.647707046042;17678.558036048944;17729.556761080818;17761.7335739964;17775.288988440578;7323.121225452873;7552.8867066994035;7647.923520764721;7746.806329841799;7763.9223607764325;6963.9303606964295;7102.360787529147;7107.111611048619;7112.25321341262;7146.785596432115;5111.7699703513435;5129.230615407719;5189.4032186299055;5229.921551176735;5243.501867322599;1441.9062760920506;1446.4503488674447;1454.7090581883665;1471.9337629806685;1479.2160155117804;777.4480119115491;886.2732559301311;906.7506435730227;921.6451666108596;921.7373048681094;8560.315174786003;8604.139586041345;8723.651053957898;8803.163699448542;8827.205551500396;722.4328901812053;731.3600599475459;732.1799584465326;736.495500582103;812.1107387410776;4904.602243244345;4970.378702662168;5048.848534543969;5459.153831156177;5701.2018317435595;21549.569008620052;21901.452463688536;22139.225127120473;22315.665265021038;22505.32484025482;21658.78341216599;21672.56654866894;22292;22414.775852241593;22474.213402530833;11000.119990400748;11334.263272887236;11395.601153959406;11413.144014198802;11421.543138274375;7968.521888686697;8209.220124088202;8289.83420331602;8315.542645154575;8330.875036874331;18291.45125646233;18886.43340699781;18999.810001900358;19029.14368853377;19189.424317270503;18584.721229181843;19246;19579.60840783205;19916.402507924206;20043.0980605876;10986.340819550853;10994.560217591206;11037.889621104008;11147.442627868737;11233.438328083399;13443.193408395528;14133.222672753098;14199.29003549839;14290;14319.642008949859;10825.458727063773;10956.890431095588;11173.329600224013;11241.156913231704;11296.774064518499;11306.208565400671;11374.488148033193;11416.372099534605;11468.655940321803;11682.94158529202;9966.252531060054;10159.796804064024;10236.948815255875;10358.792824143626;10399.53202105892;7274.127104747464;7505.4746167767735;7532.133804612539;7592.734254301073;7594.31651151399;7261.092363454568;7303.671334790053;7334.633268336668;7371.447141464519;7388.408927285912 11:22:53 INFO - PID 24609 | |4;prototype.html;496.05369051709135;520.7240162713758;522.822240438251;524.6563500906907;530.1279395394577;6405.583637063588;6431.646259455728;6445.419912207901;6456.451201647866;6477.35226477352;6165.7533698652;6196.225471816023;6237.906431403532;6241.812745617639;6355.665310284846;5158.664686795356;5177.30106435632;5239.711815850127;5268.973655131719;5269.341332333458;5146.639735218536;5238.973805130988;5249.8950020999555;5254.395744489394;5281.841544753664;4820.975895120519;4966.056449274626;4988.65079444439;5095.898082038357;5137.871553211162;4990.925136122961;5006.549410553068;5013.197888337885;5038.899222015576;5061.16490779021;4414.867553973386;4442.378067070613;4457.531959144276;4506.5493450655;4510;5874.970625146847;6028.758849646053;6046.3349031606485;6070;6094.786682466092;5681.431856814327;5701.743421546041;5709.8287051388525;5713.514351280146;5715.628484148517;6493.805185844432;6548.541602087856;6586.769463068769;6610.93389066108;6637.269900310962;4838.661293709441;4866.975665121687;4870.318155458239;4934.481879402683;4936.580390666798;6703.664816759143;6745.763898263537;6826.020454068314;6924.446044316443;6950;4996.7001979881325;5020.246962955586;5020.723860187724;5048.7728052237;5062.291279220912;5052.368453943257;5053.54518093366;5056.519630635084;5098.694078355311;5100.719460429712;5568.276124103841;5616.1014237721765;5676.318841739017;5712.885742285131;5755.625884317506;6568.211814582281;6626.56927299724;6682.732690692318;6712.730506552333;6747.6626168692355;1745.310602312105;1765.2762367429293;1768.1512873820639;1769.7256925176619;1796.5867850394482;1163.837062811207;1223.687959570304;1231.85833629132;1234.8703386144505;1240.193873981919;5639.351474580476;5699.544036477155;5727.140928860705;5736.6844823534275;5769.278815164195;6693.899591506131;6715.105238961391;6743.291954344723;6754.257031726506;6788.253292137861;5656.179853921159;5700.971495142498;5711.914321285184;5757.798477053283;5792.275965504312;3515.314513669861;3561.9492249786376;3590.9640903591153;3631.782093074424;3644.1436262478296;6451.806445806634;6501.902471462932;6506;6536.182977127859;6563.245226798884;6491.805245842632;6853.246142924274;6896.689648965808;6909.136357955255;6997.020417141604;6378.521610879203;6415.530020942064;6459.773907913201;6544.901826472606;6587.604743715392;6520.217573891164;6639.468842492685;6722.630255336004;6792.388685018372;6818.318168183142;6600.53796234259;6652.700628471827;6706.932930670826;6728.259891412039;6735.25912149673;6529.347065293433;6592.208934927839;6605.1835745170465;6613.14029176204;6639.6680165992475;4953.281774142802;5014.222795466709;5050.469700681376;5055.266986287042;5083.237514372874;6628.337166283333;6630.403263706289;6721.1598550181225;6862.553933994274;6909.654517274217;6492.350764923659;6538.738450461929;6586.045023471665;6622.178900802318;6676.465882729467;6469.967650161719;6512.185976752906;6555.344465553597;6598.142241508765;6607.603543787388;6477;6558.508111891531;6574.572652777554;6586.979018252178;6596.505262105457;6568.343165683585;6603.7688680895935;6618.404343609098;6655.267920528641;6696.397324240842;6293.622382657055;6348.9047664286;6355.046742988588;6372.776952806815;6414.230292364946 11:22:53 INFO - PID 24609 | |5;yui.html;864.4640322999741;891.224634567926;894.6019021535419;909.5588639509837;920.9401388909722;17698.38055668052;17819.821801781993;17963.550911227227;18017.729734053966;18089.366872159477;18687.439376818682;20239.392818215478;20242.898785506088;20253.898730506327;20282.695759563583;957.4446820843912;983.1643103362121;986.2307400227834;987.0524296675201;987.4075554667214;1006.104566935428;1007.4308015970953;1018.9949050254738;1019.0930072235716;1019.6329321444274;946.8958414574425;1029.130384824822;1036.984445233322;1042.6142327338857;1042.9530671119817;1016.537475448669;1016.6746641074859;1025.9948700256489;1029.2795043469525;1029.5933106422922;745.3478206569251;748.2741740511694;750.7109762741329;751.0086685575043;752.4131177681362;17888.642227155386;20155.294564690164;20327.5934481311;20377.694334584994;20399.592008159903;20850.58298834015;21136.682949755766;21347.78652213489;21394;21435;17780.110994450224;17886.28454861804;17961.461156165205;17999.280028798832;18125.00312482813;3699.408094704861;3723.832427540767;3731.197792474604;3734.439834024891;3737.5328083989502;139858.99999999898;140244;141181;141308;141861;17103.914480427517;17107.315707371567;17301.56746081358;17347.21937512815;17380.130993450275;31718.524222136686;32627.67372326294;32634;32637.673623263938;32650.836745816596;8439.324854011664;8545.487270763773;8644.913550864536;8705.042445331008;8811.691590794291;4063.4920634920636;4138.772367519755;4176.874693759192;4185.602367775056;4190.958090419118;4928.8767780805765;4934.309196712463;5345.54562862161;5460.754266058037;5468.7265636718;1132.365875109941;1156.7108222944264;1157.0801213035488;1158.7080405347976;1160.8955194032578;651.8924377477758;654.6334052930374;661.4807376209652;670.302884999595;677.2076670295766;11566.768664626661;11580.47887845049;11928.761424771455;12899.548515801902;13039.282839443922;664.6709878610119;665.7969319357545;673.8483841135803;676.7886379130956;691.8581690753383;5854.502367298827;5860.589758716934;5920.082387229986;5935.40645935403;5939;113174.43412782883;117016;117880.41059794647;118608;120819.39590302168;104598.47700761448;104724;105970.47014765031;106573;109107;88531.11468885357;88825.9999999987;88952.5552372234;90290;91064.5446772762;10731.248812583044;10827;10865.348079115278;10995.780084398108;11028.779424411627;41180;41906.161876762904;42779.35830962476;43062.56937430586;43516.347254791835;54211.72894135504;56228.43771562232;56434;57455.13817292827;57884.71057644685;16523.504294871174;16623.83376166223;16631.83368166303;16729.581760456087;16908.32366705318;16727;16777.328906843588;17287.913560432622;17363.739543907104;17370.478885633453;16533.751993720343;16581.502554923372;16815.159242038095;16835.41076062332;16911.154442278083;16649.66700666004;16662.250198741327;16764.413245536834;16887.408940687015;16950.15249237558;14897.776533352226;14917.701645967238;15041.849581504044;15066.623334416727;15220.695586088437;11899.940500297444;12131.514739410324;12427.875721242672;12463.750724985268;12600.11799174049;12224.75550489003;12248.448819802952;12363.876361236633;12467.251964882136;12523.998080153748 11:22:53 INFO - PID 24609 | __end_tp_report 11:22:53 INFO - PID 24609 | __start_cc_report 11:22:53 INFO - PID 24609 | _x_x_mozilla_cycle_collect,357 11:22:53 INFO - PID 24609 | __end_cc_report 11:22:53 INFO - PID 24609 | __startTimestamp1504894973130__endTimestamp 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | ------- Summary: start ------- 11:22:53 INFO - PID 24609 | Number of tests: 6 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#0] dojo.html Cycles:165 Average:6214.77 Median:6442.84 stddev:752.14 (11.7%) stddev-sans-first:713.88 11:22:53 INFO - PID 24609 | Values: 3108.4 3143.7 3145.0 3151.7 3172.3 6171.6 6235.8 6368.8 6372.0 6386.4 6222.0 6241.8 6251.2 6289.6 6323.1 5795.0 5813.1 5842.7 5897.8 5934.6 5859.4 5901.1 5943.0 5967.5 5983.6 5666.9 5750.5 5874.0 5883.3 5991.2 5320.7 5818.1 5863.8 5879.1 5907.4 5787.3 5797.2 5848.8 5850.8 5855.8 6183.6 6183.7 6227.4 6237.8 6257.2 6745.3 6752.1 6776.5 6803.5 6821.6 6794.8 6797.5 6883.3 6891.2 6896.8 6126.0 6254.4 6319.6 6347.0 6404.6 6835.0 6893.2 6965.3 7014.9 7024.4 6599.3 6620.5 6634.6 6676.6 6728.5 6757.9 6798.5 6812.1 6866.5 6876.3 6509.6 6663.4 6665.6 6668.9 6672.6 6629.5 6657.2 6686.7 6691.1 6708.6 5189.3 5256.6 5314.7 5316.7 5324.7 4590.6 4597.6 4678.0 4682.6 4686.3 5805.5 5878.1 5886.1 5890.0 5895.6 6816.1 6817.7 6834.2 6921.6 6923.6 5642.1 5714.8 5720.2 5737.9 5846.0 5690.7 5772.5 5836.2 5847.5 5856.0 6499.3 6509.3 6513.6 6580.4 6592.5 6822.2 6822.9 6832.8 6860.3 6913.2 6519.3 6533.1 6541.4 6620.4 6636.0 6572.3 6595.6 6690.7 6702.3 6724.2 6801.3 6806.8 6831.8 6850.3 6865.3 6584.7 6596.3 6623.9 6677.6 6678.1 6563.6 6600.5 6644.5 6649.2 6685.0 6315.7 6368.8 6431.8 6457.9 6463.9 6585.3 6604.8 6606.2 6607.6 6662.0 6334.9 6343.1 6353.6 6371.6 6442.8 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#1] ext.html Cycles:180 Average:36720.26 Median:34482.90 stddev:52266.47 (151.6%) stddev-sans-first:52343.69 11:22:53 INFO - PID 24609 | Values: 851.7 867.0 869.6 871.1 886.0 38543.8 42156.8 42191.4 42356.2 42377.6 38954.4 39473.6 39498.4 39511.6 39538.0 7094.8 7170.6 7238.7 7712.5 7937.0 7653.1 7791.3 7796.1 7817.8 7823.9 7770.9 7860.7 7861.1 7863.5 7868.5 7692.0 7757.1 7772.2 7799.9 7805.4 7742.2 7746.8 7766.8 7774.0 7817.3 38410.2 38673.2 38919.4 39004.6 39167.0 3616.4 3643.7 3655.5 3657.5 3660.5 31644.2 31717.7 31726.2 31785.4 31826.2 5101.9 5157.6 5194.9 5205.5 5283.9 187899.0 189267.0 189604.0 189605.0 189885.0 42201.6 42884.8 47722.5 48062.8 48713.8 51398.2 51672.7 51800.0 51831.7 51933.5 15801.8 15915.0 15981.7 15993.0 16013.3 13047.8 13130.3 13168.7 13177.5 13188.8 14176.1 14183.9 14217.8 14284.3 14519.5 5700.2 5802.7 5867.6 5904.7 5927.0 1009.5 1035.3 1036.2 1039.2 1047.5 22315.4 22388.0 22498.2 22524.1 22586.0 1085.9 1103.2 1115.2 1118.6 1131.7 12113.8 12150.0 12190.5 12236.0 12251.1 217556.0 219201.0 219764.0 221651.0 222247.0 52666.7 53037.2 53310.2 53357.7 53418.7 1393.2 1446.5 1455.6 1462.4 1464.7 22081.4 22670.3 22876.4 22881.8 22989.8 34475.3 34490.5 34525.7 34548.0 34583.8 194446.0 194502.0 194520.0 195149.0 196380.0 29786.3 30213.8 31524.8 32982.2 34132.5 41353.6 41997.0 42299.6 42729.8 42862.0 31146.2 31343.8 31379.2 31521.1 31553.0 27837.7 27849.6 27854.4 28199.2 28539.6 35113.5 35126.6 35180.6 35290.5 35337.8 30256.2 30410.0 30640.4 30683.4 30838.2 22422.7 22908.5 23376.6 23486.2 23526.9 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#2] jquery.html Cycles:180 Average:34040.26 Median:22468.94 stddev:80024.75 (356.2%) stddev-sans-first:80209.75 11:22:53 INFO - PID 24609 | Values: 554.6 564.7 565.3 577.2 587.3 21824.2 22670.9 22723.1 22733.7 22738.9 22797.2 23832.6 24272.2 24279.8 24519.9 6435.4 6528.5 6566.7 6568.0 6573.3 6326.9 6525.8 6541.2 6541.9 6550.7 6159.2 6438.3 6459.8 6465.9 6500.5 6420.7 6520.1 6520.5 6526.7 6529.3 5579.1 5799.7 5801.3 5824.4 6033.6 27541.2 27893.2 28072.0 28125.3 28160.0 2033.5 2070.7 2071.3 2071.3 2072.1 18258.5 18776.2 18927.7 19169.7 19573.1 2354.4 2399.6 2408.7 2412.5 2425.8 122215.0 127415.0 136296.0 143477.3 143866.0 14099.3 14119.2 14195.3 14378.6 14412.1 22304.0 22460.6 22477.3 22486.4 22494.9 9843.9 10093.1 10185.2 10327.1 10340.3 9332.2 9378.8 9470.5 9477.8 9565.4 8699.3 8741.3 8954.0 8987.9 9167.6 2516.8 2552.4 2626.5 2638.7 2657.7 931.9 962.2 970.4 973.9 980.9 18358.6 18736.3 18961.3 19289.4 19333.0 1020.9 1024.3 1024.9 1026.3 1028.6 10464.6 10528.8 10536.5 10685.4 10776.2 463500.0 470006.0 470204.0 481650.0 491656.0 106943.0 107292.5 110069.4 110345.0 111621.4 1016.5 1040.5 1123.2 1139.2 1180.8 19467.0 19666.6 20050.5 20119.3 20206.5 54331.5 55804.0 56562.0 56575.4 57096.7 68490.7 68944.0 69930.0 70136.3 70414.3 19413.8 19579.4 19733.5 19770.5 19863.5 21895.5 22161.9 22312.9 22346.0 22539.9 17763.2 17925.3 17986.7 18022.5 18160.5 14514.1 14595.4 14604.3 15572.6 15633.9 17782.1 17922.8 17940.7 18065.6 18336.0 19128.4 19241.3 19323.3 19465.9 19476.5 17433.4 17660.8 17773.2 17923.3 18131.6 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#3] mootools.html Cycles:180 Average:9462.39 Median:14920.57 stddev:6809.46 (45.6%) stddev-sans-first:6801.05 11:22:53 INFO - PID 24609 | Values: 1316.2 1379.2 1386.8 1401.1 1401.5 14896.5 15512.9 15519.8 15554.7 15560.4 15217.4 15372.3 15381.2 15405.7 15415.0 2773.6 2801.5 2840.6 2844.8 2863.2 2708.4 2795.7 2819.5 2827.4 2833.0 2713.4 2714.4 2810.1 2811.8 2812.8 2839.9 2841.5 2847.4 2849.5 2862.2 2670.9 2711.3 2716.5 2720.2 2723.1 14799.6 15192.5 15207.7 15229.4 15268.8 7966.2 8314.4 8358.1 8398.9 8405.1 5361.6 5629.7 5773.2 5780.8 5808.8 1919.7 1946.8 1959.3 1973.1 1994.1 26887.1 27024.3 27053.7 27127.7 27277.3 6741.6 6940.0 7050.3 7089.5 7126.6 17614.6 17678.6 17729.6 17761.7 17775.3 7323.1 7552.9 7647.9 7746.8 7763.9 6963.9 7102.4 7107.1 7112.3 7146.8 5111.8 5129.2 5189.4 5229.9 5243.5 1441.9 1446.5 1454.7 1471.9 1479.2 777.4 886.3 906.8 921.6 921.7 8560.3 8604.1 8723.7 8803.2 8827.2 722.4 731.4 732.2 736.5 812.1 4904.6 4970.4 5048.8 5459.2 5701.2 21549.6 21901.5 22139.2 22315.7 22505.3 21658.8 21672.6 22292.0 22414.8 22474.2 11000.1 11334.3 11395.6 11413.1 11421.5 7968.5 8209.2 8289.8 8315.5 8330.9 18291.5 18886.4 18999.8 19029.1 19189.4 18584.7 19246.0 19579.6 19916.4 20043.1 10986.3 10994.6 11037.9 11147.4 11233.4 13443.2 14133.2 14199.3 14290.0 14319.6 10825.5 10956.9 11173.3 11241.2 11296.8 11306.2 11374.5 11416.4 11468.7 11682.9 9966.3 10159.8 10236.9 10358.8 10399.5 7274.1 7505.5 7532.1 7592.7 7594.3 7261.1 7303.7 7334.6 7371.4 7388.4 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#4] prototype.html Cycles:180 Average:5544.90 Median:6180.99 stddev:1549.22 (25.1%) stddev-sans-first:1506.51 11:22:53 INFO - PID 24609 | Values: 496.1 520.7 522.8 524.7 530.1 6405.6 6431.6 6445.4 6456.5 6477.4 6165.8 6196.2 6237.9 6241.8 6355.7 5158.7 5177.3 5239.7 5269.0 5269.3 5146.6 5239.0 5249.9 5254.4 5281.8 4821.0 4966.1 4988.7 5095.9 5137.9 4990.9 5006.5 5013.2 5038.9 5061.2 4414.9 4442.4 4457.5 4506.5 4510.0 5875.0 6028.8 6046.3 6070.0 6094.8 5681.4 5701.7 5709.8 5713.5 5715.6 6493.8 6548.5 6586.8 6610.9 6637.3 4838.7 4867.0 4870.3 4934.5 4936.6 6703.7 6745.8 6826.0 6924.4 6950.0 4996.7 5020.2 5020.7 5048.8 5062.3 5052.4 5053.5 5056.5 5098.7 5100.7 5568.3 5616.1 5676.3 5712.9 5755.6 6568.2 6626.6 6682.7 6712.7 6747.7 1745.3 1765.3 1768.2 1769.7 1796.6 1163.8 1223.7 1231.9 1234.9 1240.2 5639.4 5699.5 5727.1 5736.7 5769.3 6693.9 6715.1 6743.3 6754.3 6788.3 5656.2 5701.0 5711.9 5757.8 5792.3 3515.3 3561.9 3591.0 3631.8 3644.1 6451.8 6501.9 6506.0 6536.2 6563.2 6491.8 6853.2 6896.7 6909.1 6997.0 6378.5 6415.5 6459.8 6544.9 6587.6 6520.2 6639.5 6722.6 6792.4 6818.3 6600.5 6652.7 6706.9 6728.3 6735.3 6529.3 6592.2 6605.2 6613.1 6639.7 4953.3 5014.2 5050.5 5055.3 5083.2 6628.3 6630.4 6721.2 6862.6 6909.7 6492.4 6538.7 6586.0 6622.2 6676.5 6470.0 6512.2 6555.3 6598.1 6607.6 6477.0 6558.5 6574.6 6587.0 6596.5 6568.3 6603.8 6618.4 6655.3 6696.4 6293.6 6348.9 6355.0 6372.8 6414.2 11:22:53 INFO - PID 24609 | 11:22:53 INFO - PID 24609 | [#5] yui.html Cycles:180 Average:24042.54 Median:17981.42 stddev:34450.10 (191.6%) stddev-sans-first:34502.79 11:22:53 INFO - PID 24609 | Values: 864.5 891.2 894.6 909.6 920.9 17698.4 17819.8 17963.6 18017.7 18089.4 18687.4 20239.4 20242.9 20253.9 20282.7 957.4 983.2 986.2 987.1 987.4 1006.1 1007.4 1019.0 1019.1 1019.6 946.9 1029.1 1037.0 1042.6 1043.0 1016.5 1016.7 1026.0 1029.3 1029.6 745.3 748.3 750.7 751.0 752.4 17888.6 20155.3 20327.6 20377.7 20399.6 20850.6 21136.7 21347.8 21394.0 21435.0 17780.1 17886.3 17961.5 17999.3 18125.0 3699.4 3723.8 3731.2 3734.4 3737.5 139859.0 140244.0 141181.0 141308.0 141861.0 17103.9 17107.3 17301.6 17347.2 17380.1 31718.5 32627.7 32634.0 32637.7 32650.8 8439.3 8545.5 8644.9 8705.0 8811.7 4063.5 4138.8 4176.9 4185.6 4191.0 4928.9 4934.3 5345.5 5460.8 5468.7 1132.4 1156.7 1157.1 1158.7 1160.9 651.9 654.6 661.5 670.3 677.2 11566.8 11580.5 11928.8 12899.5 13039.3 664.7 665.8 673.8 676.8 691.9 5854.5 5860.6 5920.1 5935.4 5939.0 113174.4 117016.0 117880.4 118608.0 120819.4 104598.5 104724.0 105970.5 106573.0 109107.0 88531.1 88826.0 88952.6 90290.0 91064.5 10731.2 10827.0 10865.3 10995.8 11028.8 41180.0 41906.2 42779.4 43062.6 43516.3 54211.7 56228.4 56434.0 57455.1 57884.7 16523.5 16623.8 16631.8 16729.6 16908.3 16727.0 16777.3 17287.9 17363.7 17370.5 16533.8 16581.5 16815.2 16835.4 16911.2 16649.7 16662.3 16764.4 16887.4 16950.2 14897.8 14917.7 15041.8 15066.6 15220.7 11899.9 12131.5 12427.9 12463.8 12600.1 12224.8 12248.4 12363.9 12467.3 12524.0 11:22:53 INFO - PID 24609 | -------- Summary: end -------- 11:22:53 INFO - PID 24609 | 11:22:54 INFO - TEST-INFO | 24609: exit 0 11:22:54 INFO - TEST-OK | dromaeo_css | took 1113668ms 11:22:54 INFO - TEST-START | kraken 11:22:54 INFO - Initialising browser for kraken test... 11:22:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54860/getInfo.html -profile /tmp/tmpLqajLd/profile 11:22:54 INFO - TEST-INFO | started process 24999 (/builds/slave/test/build/application/firefox/firefox http://localhost:54860/getInfo.html) 11:22:59 INFO - TEST-INFO | 24999: exit 0 11:22:59 INFO - Browser initialized. 11:22:59 INFO - Running cycle 1/1 for kraken test... 11:22:59 INFO - Using env: {'DISPLAY': ':0', 11:22:59 INFO - 'HOME': '/home/cltbld', 11:22:59 INFO - 'JSGC_DISABLE_POISONING': '1', 11:22:59 INFO - 'LANG': 'en_US.UTF-8', 11:22:59 INFO - 'LANGUAGE': 'en_US:en', 11:22:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:22:59 INFO - 'LOGNAME': 'cltbld', 11:22:59 INFO - 'MAIL': '/var/mail/cltbld', 11:22:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:59 INFO - 'MOZ_ACCELERATED': '1', 11:22:59 INFO - 'MOZ_CRASHREPORTER': '1', 11:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:22:59 INFO - 'MOZ_NO_REMOTE': '1', 11:22:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:59 INFO - 'MOZ_WEBRENDER': '1', 11:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:59 INFO - 'NO_EM_RESTART': '1', 11:22:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:59 INFO - 'PWD': '/builds/slave/test', 11:22:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:59 INFO - 'RUST_BACKTRACE': 'full', 11:22:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:59 INFO - 'SHELL': '/bin/bash', 11:22:59 INFO - 'SHLVL': '1', 11:22:59 INFO - 'TERM': 'linux', 11:22:59 INFO - 'TMOUT': '86400', 11:22:59 INFO - 'USER': 'cltbld', 11:22:59 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892', 11:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:59 INFO - '_': '/tools/buildbot/bin/python'} 11:22:59 INFO - TEST-INFO | started process 25206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLqajLd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:00 INFO - PID 25206 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:23:01 INFO - PID 25206 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:23:01 INFO - PID 25206 | 11:23:01 INFO - PID 25206 | (/builds/slave/test/build/application/firefox/firefox:25268): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:23:01 INFO - PID 25206 | 11:23:11 INFO - PID 25206 | RSS: Main: 213921792 11:23:11 INFO - PID 25206 | 11:23:14 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54860/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:15 INFO - PID 25206 | RSS: Main: 220663808 11:23:15 INFO - PID 25206 | 11:23:17 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54860/tests/kraken/driver.html?testName=audio-dft) 11:23:18 INFO - PID 25206 | RSS: Main: 221790208 11:23:18 INFO - PID 25206 | 11:23:21 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54860/tests/kraken/driver.html?testName=audio-fft) 11:23:22 INFO - PID 25206 | RSS: Main: 215416832 11:23:22 INFO - PID 25206 | 11:23:24 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54860/tests/kraken/driver.html?testName=audio-oscillator) 11:23:25 INFO - PID 25206 | RSS: Main: 216793088 11:23:25 INFO - PID 25206 | 11:23:27 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:27 INFO - PID 25206 | RSS: Main: 217300992 11:23:27 INFO - PID 25206 | 11:23:31 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54860/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:31 INFO - PID 25206 | RSS: Main: 218992640 11:23:31 INFO - PID 25206 | 11:23:35 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54860/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:35 INFO - PID 25206 | RSS: Main: 217763840 11:23:35 INFO - PID 25206 | 11:23:38 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54860/tests/kraken/driver.html?testName=json-parse-financial) 11:23:39 INFO - PID 25206 | RSS: Main: 220098560 11:23:39 INFO - PID 25206 | 11:23:41 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:41 INFO - PID 25206 | RSS: Main: 219607040 11:23:41 INFO - PID 25206 | 11:23:43 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:44 INFO - PID 25206 | RSS: Main: 219951104 11:23:44 INFO - PID 25206 | 11:23:46 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:47 INFO - PID 25206 | RSS: Main: 215539712 11:23:47 INFO - PID 25206 | 11:23:49 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:50 INFO - PID 25206 | RSS: Main: 216797184 11:23:50 INFO - PID 25206 | 11:23:53 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:53 INFO - PID 25206 | RSS: Main: 217108480 11:23:53 INFO - PID 25206 | 11:23:55 INFO - PID 25206 | Cycle 1(1): loaded http://localhost:54860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54860/tests/kraken/driver.html?testName=ai-astar) 11:23:56 INFO - PID 25206 | RSS: Main: 218574848 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | __start_tp_report 11:23:56 INFO - PID 25206 | _x_x_mozilla_page_load 11:23:56 INFO - PID 25206 | _x_x_mozilla_page_load_details 11:23:56 INFO - PID 25206 | |i|pagename|runs| 11:23:56 INFO - PID 25206 | |0;ai-astar;109;113;107;109;109;108;111;108;115;108 11:23:56 INFO - PID 25206 | |1;audio-beat-detection;125;117;121;120;117;123;127;152;120;124 11:23:56 INFO - PID 25206 | |2;audio-dft;164;164;170;168;178;172;169;172;166;168 11:23:56 INFO - PID 25206 | |3;audio-fft;81;74;74;75;89;76;73;76;73;77 11:23:56 INFO - PID 25206 | |4;audio-oscillator;87;83;79;84;79;80;79;89;80;78 11:23:56 INFO - PID 25206 | |5;imaging-gaussian-blur;114;115;115;120;115;115;113;121;114;124 11:23:56 INFO - PID 25206 | |6;imaging-darkroom;150;153;149;148;149;151;149;152;149;150 11:23:56 INFO - PID 25206 | |7;imaging-desaturate;100;98;100;97;94;95;94;94;95;104 11:23:56 INFO - PID 25206 | |8;json-parse-financial;54;55;52;52;55;58;53;52;53;53 11:23:56 INFO - PID 25206 | |9;json-stringify-tinderbox;37;48;45;42;43;47;37;37;38;37 11:23:56 INFO - PID 25206 | |10;stanford-crypto-aes;76;83;83;81;76;77;84;77;86;81 11:23:56 INFO - PID 25206 | |11;stanford-crypto-ccm;134;119;127;120;131;118;127;127;116;131 11:23:56 INFO - PID 25206 | |12;stanford-crypto-pbkdf2;177;180;169;173;173;175;168;165;169;169 11:23:56 INFO - PID 25206 | |13;stanford-crypto-sha256-iterative;64;64;66;68;62;65;63;64;65;68 11:23:56 INFO - PID 25206 | __end_tp_report 11:23:56 INFO - PID 25206 | __start_cc_report 11:23:56 INFO - PID 25206 | _x_x_mozilla_cycle_collect,947 11:23:56 INFO - PID 25206 | __end_cc_report 11:23:56 INFO - PID 25206 | __startTimestamp1504895036059__endTimestamp 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | ------- Summary: start ------- 11:23:56 INFO - PID 25206 | Number of tests: 14 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#0] ai-astar Cycles:10 Average:109.70 Median:109.00 stddev:2.54 (2.3%) stddev-sans-first:2.68 11:23:56 INFO - PID 25206 | Values: 109.0 113.0 107.0 109.0 109.0 108.0 111.0 108.0 115.0 108.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:123.50 stddev:10.17 (8.2%) stddev-sans-first:10.78 11:23:56 INFO - PID 25206 | Values: 125.0 117.0 121.0 120.0 117.0 123.0 127.0 152.0 120.0 124.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#2] audio-dft Cycles:10 Average:169.10 Median:169.50 stddev:4.23 (2.5%) stddev-sans-first:4.06 11:23:56 INFO - PID 25206 | Values: 164.0 164.0 170.0 168.0 178.0 172.0 169.0 172.0 166.0 168.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#3] audio-fft Cycles:10 Average:76.80 Median:76.00 stddev:4.89 (6.4%) stddev-sans-first:4.95 11:23:56 INFO - PID 25206 | Values: 81.0 74.0 74.0 75.0 89.0 76.0 73.0 76.0 73.0 77.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:81.50 stddev:3.79 (4.7%) stddev-sans-first:3.53 11:23:56 INFO - PID 25206 | Values: 87.0 83.0 79.0 84.0 79.0 80.0 79.0 89.0 80.0 78.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:115.00 stddev:3.69 (3.2%) stddev-sans-first:3.79 11:23:56 INFO - PID 25206 | Values: 114.0 115.0 115.0 120.0 115.0 115.0 113.0 121.0 114.0 124.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 11:23:56 INFO - PID 25206 | Values: 150.0 153.0 149.0 148.0 149.0 151.0 149.0 152.0 149.0 150.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:94.50 stddev:3.38 (3.6%) stddev-sans-first:3.42 11:23:56 INFO - PID 25206 | Values: 100.0 98.0 100.0 97.0 94.0 95.0 94.0 94.0 95.0 104.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.89 (3.5%) stddev-sans-first:2.00 11:23:56 INFO - PID 25206 | Values: 54.0 55.0 52.0 52.0 55.0 58.0 53.0 52.0 53.0 53.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#9] json-stringify-tinderbox Cycles:10 Average:41.10 Median:42.50 stddev:4.46 (10.5%) stddev-sans-first:4.48 11:23:56 INFO - PID 25206 | Values: 37.0 48.0 45.0 42.0 43.0 47.0 37.0 37.0 38.0 37.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:82.00 stddev:3.66 (4.5%) stddev-sans-first:3.52 11:23:56 INFO - PID 25206 | Values: 76.0 83.0 83.0 81.0 76.0 77.0 84.0 77.0 86.0 81.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:6.29 (5.0%) stddev-sans-first:5.77 11:23:56 INFO - PID 25206 | Values: 134.0 119.0 127.0 120.0 131.0 118.0 127.0 127.0 116.0 131.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:4.61 (2.7%) stddev-sans-first:4.49 11:23:56 INFO - PID 25206 | Values: 177.0 180.0 169.0 173.0 173.0 175.0 168.0 165.0 169.0 169.0 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.97 (3.0%) stddev-sans-first:2.06 11:23:56 INFO - PID 25206 | Values: 64.0 64.0 66.0 68.0 62.0 65.0 63.0 64.0 65.0 68.0 11:23:56 INFO - PID 25206 | -------- Summary: end -------- 11:23:56 INFO - PID 25206 | 11:23:56 INFO - PID 25206 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:56 INFO - TEST-INFO | 25206: exit 0 11:23:56 INFO - TEST-OK | kraken | took 62831ms 11:23:56 INFO - SUITE-END | took 1176s 11:23:57 INFO - Completed test suite (00:19:36) 11:23:57 INFO - javascript benchmark 11:23:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.368274448325, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.4404807134715, 3143.732782713469, 3144.9842750786256, 3151.6848315168486, 3172.254520187756, 6171.598846075002, 6235.812925612227, 6368.777092801753, 6372.0, 6386.393292637198, 6222.0, 6241.750329986807, 6251.156093927319, 6289.559730818844, 6323.146375239353, 5794.971025144879, 5813.09896965971, 5842.707864606774, 5897.823065308026, 5934.614250073753, 5859.355470898197, 5901.05583106703, 5942.970285148568, 5967.462928336449, 5983.58114931955, 5666.858328541778, 5750.539956803445, 5874.00141975863, 5883.264591926009, 5991.191189189469, 5320.737919778441, 5818.1272809078555, 5863.76544938202, 5879.088741245114, 5907.409259074101, 5787.33445653751, 5797.188393624896, 5848.824535263949, 5850.795222167204, 5855.795047173328, 6183.628982261079, 6183.690815459209, 6227.439530442282, 6237.844053898643, 6257.186565746424, 6745.258021617618, 6752.1222241108835, 6776.525643204977, 6803.48973826965, 6821.590704557742, 6794.796156115324, 6797.456203503757, 6883.3116688331265, 6891.207511136183, 6896.7586134485555, 6125.96937015321, 6254.374562543755, 6319.6208227506495, 6347.016212487118, 6404.647744374058, 6835.0, 6893.20728116273, 6965.268646792014, 7014.92985070153, 7024.367806897301, 6599.340065993459, 6620.470362370998, 6634.568753031038, 6676.6327851967635, 6728.495362847806, 6757.898631520531, 6798.5241033128195, 6812.080369150201, 6866.450683945272, 6876.346747059021, 6509.609423434609, 6663.400293973566, 6665.633390163491, 6668.86662266752, 6672.566283191577, 6629.469642428594, 6657.167854018247, 6686.699098540577, 6691.0967019451755, 6708.597484150967, 5189.273501709688, 5256.632035757537, 5314.70769107695, 5316.6544174628525, 5324.653897496651, 4590.586847183769, 4597.586217240398, 4677.953220467752, 4682.6253899687945, 4686.343911852344, 5805.535557155417, 5878.147668588116, 5886.1465087562065, 5890.0, 5895.616784908967, 6816.113905192294, 6817.659117044128, 6834.179898412222, 6921.550099243533, 6923.6192009438955, 5642.069058605366, 5714.7999820006935, 5720.1991721159075, 5737.8565535861935, 5846.0, 5690.748035432198, 5772.480476757112, 5836.182934389189, 5847.532197424196, 5856.0, 6499.252585952676, 6509.251436084816, 6513.576617519846, 6580.374864387875, 6592.472602191813, 6822.249552549315, 6822.931770682229, 6832.760853370109, 6860.279670634512, 6913.170419549686, 6519.315471875385, 6533.118029066015, 6541.411272985264, 6620.404163625297, 6636.0377745225705, 6572.277049524453, 6595.637239951849, 6690.698918548775, 6702.262751097473, 6724.193096828412, 6801.251862295045, 6806.76176333826, 6831.795046148424, 6850.280720524273, 6865.27914568963, 6584.670766461562, 6596.30738772422, 6623.933760662332, 6677.632730199885, 6678.098456708282, 6563.638999855054, 6600.53796234259, 6644.501662375438, 6649.235337936199, 6684.966575167093, 6315.684215789101, 6368.840778980562, 6431.807045788634, 6457.870842583028, 6463.935360646334, 6585.275619681927, 6604.768833090819, 6606.240282367589, 6607.636579988147, 6661.966690166518, 6334.904976425265, 6343.080253363329, 6353.618782873043, 6371.649559274284, 6442.8389290268115], "value": 6156.839011860149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.7359618518259, 866.9653213871445, 869.647792643979, 871.0766587417341, 886.03422269726, 38543.80728096363, 42156.789216053876, 42191.36712949308, 42356.152876942484, 42377.576224237746, 38954.415683764695, 39473.60526394735, 39498.40752388717, 39511.60488395115, 39538.0, 7094.751683691059, 7170.60561669108, 7238.71045158193, 7712.5372477651235, 7937.0, 7653.081630204383, 7791.298783109519, 7796.142424333319, 7817.843643127134, 7823.904653348536, 7770.883436748425, 7860.724874629389, 7861.056673199224, 7863.488873223251, 7868.52788832669, 7691.961540192319, 7757.107932587768, 7772.183920688303, 7799.883001754978, 7805.37556995439, 7742.225777422269, 7746.767596972099, 7766.805829854299, 7774.0, 7817.257360550795, 38410.231795363936, 38673.22653546913, 38919.41620875689, 39004.609953900384, 39167.0, 3616.3671357512594, 3643.6902863256655, 3655.524781778352, 3657.5062366580437, 3660.5241318628673, 31644.208894777585, 31717.682823171934, 31726.206844828834, 31785.364292714017, 31826.204344891332, 5101.897962040775, 5157.638965272433, 5194.896102077937, 5205.479452054802, 5283.9471605284225, 187899.0, 189267.0, 189604.0, 189604.99999999863, 189885.0, 42201.57798422038, 42884.78557607192, 47722.52277477181, 48062.759686202044, 48713.75643121762, 51398.22902656463, 51672.741636291576, 51800.0, 51831.740841296305, 51933.48066519287, 15801.762973555406, 15915.0450972942, 15981.680366392608, 15993.040417574983, 16013.279402426919, 13047.804282935764, 13130.34348282582, 13168.670783230496, 13177.47290108404, 13188.802167967488, 14176.149431034171, 14183.858161418253, 14217.786733199011, 14284.285785710674, 14519.491817786327, 5700.173474846124, 5802.738876750556, 5867.589268751147, 5904.675242861684, 5927.0, 1009.5103874620803, 1035.2597892506744, 1036.1658864613908, 1039.2153923787491, 1047.4814966591587, 22315.44211394728, 22387.97773284425, 22498.21256256056, 22524.099036038377, 22586.0, 1085.9076978456762, 1103.194667892443, 1115.1803424482998, 1118.5917140243914, 1131.7114135895295, 12113.818292725617, 12150.0, 12190.51237950472, 12236.0, 12251.14242003069, 217556.0, 219201.0, 219764.0, 221651.0, 222247.0, 52666.73666631642, 53037.20444193263, 53310.200346994825, 53357.733211333696, 53418.73290633522, 1393.171063217384, 1446.5154173352046, 1455.6288146522782, 1462.4223431744401, 1464.6777708904024, 22081.447963801034, 22670.319890402654, 22876.4280892979, 22881.77118228863, 22989.770102299433, 34475.31049378948, 34490.48264276088, 34525.65474345224, 34548.0, 34583.82708086444, 194446.0, 194502.0, 194520.0, 195149.0, 196380.0, 29786.255343616584, 30213.848930755204, 31524.842375787975, 32982.175445614055, 34132.488012679336, 41353.58646413618, 41997.0, 42299.57700422956, 42729.78635106805, 42862.0, 31146.221344465663, 31343.84328078345, 31379.215519612193, 31521.054368368987, 31553.0, 27837.721622783512, 27849.582256265767, 27854.44291114207, 28199.15402537927, 28539.571906421836, 35113.47329790004, 35126.64873351234, 35180.64819351876, 35290.470642939865, 35337.82331088328, 30256.243593910327, 30410.0, 30640.387192256476, 30683.386332272785, 30838.229044273176, 22422.663660044786, 22908.48678663576, 23376.64935025942, 23486.177983770485, 23526.882365588062], "value": 16930.38559978246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5702080887312, 564.7148190163966, 565.3498476751734, 577.1775220311056, 587.2571197435244, 21824.23615173469, 22670.88664556677, 22723.091076356926, 22733.658995115085, 22738.88630556849, 22797.202097926576, 23832.64251036236, 24272.15047473339, 24279.75720242797, 24519.87740061297, 6435.420812126896, 6528.543001989862, 6566.737330506798, 6567.967160164192, 6573.342665733412, 6326.873462530747, 6525.771597994071, 6541.21505419348, 6541.901871471931, 6550.672466376686, 6159.199304090462, 6438.259600145973, 6459.838504037413, 6465.935340646603, 6500.479961603084, 6420.711068001951, 6520.054592084145, 6520.543561950665, 6526.706298216592, 6529.347065293457, 5579.079451890433, 5799.652020878719, 5801.274840644919, 5824.417558244184, 6033.607815491979, 27541.173764787087, 27893.16320510388, 28072.017479388327, 28125.29686757827, 28160.0, 2033.4509682385822, 2070.6893965905083, 2071.295759441797, 2071.326818783886, 2072.1297055236837, 18258.543536411562, 18776.155073021746, 18927.716084258747, 19169.712454313198, 19573.119209635457, 2354.376090336062, 2399.58007348715, 2408.7350391456926, 2412.541617092764, 2425.7938075263623, 122215.0, 127415.0, 136296.0, 143477.2826135873, 143866.0, 14099.295035248197, 14119.223442710749, 14195.290235488184, 14378.640533986734, 14412.13527188372, 22304.0, 22460.55078898413, 22477.32568022962, 22486.437839053826, 22494.887525562266, 9843.852342214872, 10093.091621754078, 10185.236107291983, 10327.122194613543, 10340.27618066728, 9332.206762425134, 9378.765530861647, 9470.52647367629, 9477.763055923657, 9565.378250413702, 8699.347548933856, 8741.256993155654, 8954.0, 8987.910120898838, 9167.633294668138, 2516.848989060662, 2552.4257042165364, 2626.500964816679, 2638.7493188147096, 2657.707652158261, 931.9068093190626, 962.2206013129388, 970.4080510888352, 973.8928717841031, 980.9117179453883, 18358.63282734338, 18736.250549978122, 18961.336353227573, 19289.421317360502, 19333.0, 1020.9336393134422, 1024.3188279793853, 1024.8770147582188, 1026.3021145621049, 1028.5834237133972, 10464.581416743396, 10528.789424211625, 10536.473176341153, 10685.412302323446, 10776.19178561611, 463500.0, 470006.0, 470204.0, 481650.0, 491656.0, 106943.0, 107292.46353768338, 110069.44965275122, 110345.0, 111621.44189279164, 1016.4968340671415, 1040.5213601743283, 1123.1576317761678, 1139.2171251990608, 1180.7992641251008, 19467.0, 19666.60666786685, 20050.498737531678, 20119.295824646066, 20206.494837629176, 54331.45668543264, 55804.0, 56562.0, 56575.434245657016, 57096.71451642715, 68490.65754671195, 68944.0, 69930.0, 70136.29863701298, 70414.29585704078, 19413.8058619412, 19579.412617621496, 19733.506662333555, 19770.50573735668, 19863.503412414804, 21895.45261368415, 22161.88919055459, 22312.888435557717, 22346.0, 22539.88730056339, 17763.20065597077, 17925.28298868083, 17986.730199047288, 18022.5494362642, 18160.455186344432, 14514.129152250476, 14595.416183352547, 14604.342804573607, 15572.610684732519, 15633.921830390775, 17782.110894455484, 17922.820771792638, 17940.730889036935, 18065.638687225917, 18336.0, 19128.426147215607, 19241.326553570558, 19323.323683671006, 19465.902670486557, 19476.513087172934, 17433.389831355842, 17660.823391765916, 17773.200205990503, 17923.28306867763, 18131.637367252846], "value": 11891.310748613338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.1773891317926, 1379.2276325257853, 1386.7781155015193, 1401.1102949626998, 1401.474447082344, 14896.47862324819, 15512.922435387807, 15519.84480155198, 15554.688906221869, 15560.37758489659, 15217.39130434784, 15372.308246128923, 15381.23093845306, 15405.691886162298, 15415.0, 2773.55623100304, 2801.5097357962377, 2840.6449193850767, 2844.772418206549, 2863.1983044747503, 2708.404151086768, 2795.6784969728437, 2819.520681484142, 2827.406244688618, 2832.957505637417, 2713.4030513287144, 2714.3892624159603, 2810.12886005338, 2811.8172318799316, 2812.8312301261885, 2839.886404543816, 2841.502737021023, 2847.430513897229, 2849.487092323381, 2862.212891454856, 2670.8798104085167, 2711.295063283541, 2716.5246081935584, 2720.2111387697546, 2723.1149876290283, 14799.556013319618, 15192.544223673307, 15207.695846083016, 15229.390824367123, 15268.77096843537, 7966.163552826928, 8314.41799074065, 8358.122397148334, 8398.916010839936, 8405.075441701469, 5361.624686271963, 5629.7185140742795, 5773.220615216934, 5780.826575202751, 5808.82573522795, 1919.6928491441302, 1946.7858535561077, 1959.2750682247517, 1973.0923775063488, 1994.0926878270498, 26887.05895293675, 27024.324391890164, 27053.729462705516, 27127.728722712916, 27277.318067048283, 6741.629210393476, 6939.959006149118, 7050.259722729143, 7089.539179953286, 7126.572405655574, 17614.647707046042, 17678.558036048944, 17729.556761080818, 17761.7335739964, 17775.288988440578, 7323.121225452873, 7552.8867066994035, 7647.923520764721, 7746.806329841799, 7763.9223607764325, 6963.9303606964295, 7102.360787529147, 7107.111611048619, 7112.25321341262, 7146.785596432115, 5111.7699703513435, 5129.230615407719, 5189.4032186299055, 5229.921551176735, 5243.501867322599, 1441.9062760920506, 1446.4503488674447, 1454.7090581883665, 1471.9337629806685, 1479.2160155117804, 777.4480119115491, 886.2732559301311, 906.7506435730227, 921.6451666108596, 921.7373048681094, 8560.315174786003, 8604.139586041345, 8723.651053957898, 8803.163699448542, 8827.205551500396, 722.4328901812053, 731.3600599475459, 732.1799584465326, 736.495500582103, 812.1107387410776, 4904.602243244345, 4970.378702662168, 5048.848534543969, 5459.153831156177, 5701.2018317435595, 21549.569008620052, 21901.452463688536, 22139.225127120473, 22315.665265021038, 22505.32484025482, 21658.78341216599, 21672.56654866894, 22292.0, 22414.775852241593, 22474.213402530833, 11000.119990400748, 11334.263272887236, 11395.601153959406, 11413.144014198802, 11421.543138274375, 7968.521888686697, 8209.220124088202, 8289.83420331602, 8315.542645154575, 8330.875036874331, 18291.45125646233, 18886.43340699781, 18999.810001900358, 19029.14368853377, 19189.424317270503, 18584.721229181843, 19246.0, 19579.60840783205, 19916.402507924206, 20043.0980605876, 10986.340819550853, 10994.560217591206, 11037.889621104008, 11147.442627868737, 11233.438328083399, 13443.193408395528, 14133.222672753098, 14199.29003549839, 14290.0, 14319.642008949859, 10825.458727063773, 10956.890431095588, 11173.329600224013, 11241.156913231704, 11296.774064518499, 11306.208565400671, 11374.488148033193, 11416.372099534605, 11468.655940321803, 11682.94158529202, 9966.252531060054, 10159.796804064024, 10236.948815255875, 10358.792824143626, 10399.53202105892, 7274.127104747464, 7505.4746167767735, 7532.133804612539, 7592.734254301073, 7594.31651151399, 7261.092363454568, 7303.671334790053, 7334.633268336668, 7371.447141464519, 7388.408927285912], "value": 6712.383421431864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.05369051709135, 520.7240162713758, 522.822240438251, 524.6563500906907, 530.1279395394577, 6405.583637063588, 6431.646259455728, 6445.419912207901, 6456.451201647866, 6477.35226477352, 6165.7533698652, 6196.225471816023, 6237.906431403532, 6241.812745617639, 6355.665310284846, 5158.664686795356, 5177.30106435632, 5239.711815850127, 5268.973655131719, 5269.341332333458, 5146.639735218536, 5238.973805130988, 5249.8950020999555, 5254.395744489394, 5281.841544753664, 4820.975895120519, 4966.056449274626, 4988.65079444439, 5095.898082038357, 5137.871553211162, 4990.925136122961, 5006.549410553068, 5013.197888337885, 5038.899222015576, 5061.16490779021, 4414.867553973386, 4442.378067070613, 4457.531959144276, 4506.5493450655, 4510.0, 5874.970625146847, 6028.758849646053, 6046.3349031606485, 6070.0, 6094.786682466092, 5681.431856814327, 5701.743421546041, 5709.8287051388525, 5713.514351280146, 5715.628484148517, 6493.805185844432, 6548.541602087856, 6586.769463068769, 6610.93389066108, 6637.269900310962, 4838.661293709441, 4866.975665121687, 4870.318155458239, 4934.481879402683, 4936.580390666798, 6703.664816759143, 6745.763898263537, 6826.020454068314, 6924.446044316443, 6950.0, 4996.7001979881325, 5020.246962955586, 5020.723860187724, 5048.7728052237, 5062.291279220912, 5052.368453943257, 5053.54518093366, 5056.519630635084, 5098.694078355311, 5100.719460429712, 5568.276124103841, 5616.1014237721765, 5676.318841739017, 5712.885742285131, 5755.625884317506, 6568.211814582281, 6626.56927299724, 6682.732690692318, 6712.730506552333, 6747.6626168692355, 1745.310602312105, 1765.2762367429293, 1768.1512873820639, 1769.7256925176619, 1796.5867850394482, 1163.837062811207, 1223.687959570304, 1231.85833629132, 1234.8703386144505, 1240.193873981919, 5639.351474580476, 5699.544036477155, 5727.140928860705, 5736.6844823534275, 5769.278815164195, 6693.899591506131, 6715.105238961391, 6743.291954344723, 6754.257031726506, 6788.253292137861, 5656.179853921159, 5700.971495142498, 5711.914321285184, 5757.798477053283, 5792.275965504312, 3515.314513669861, 3561.9492249786376, 3590.9640903591153, 3631.782093074424, 3644.1436262478296, 6451.806445806634, 6501.902471462932, 6506.0, 6536.182977127859, 6563.245226798884, 6491.805245842632, 6853.246142924274, 6896.689648965808, 6909.136357955255, 6997.020417141604, 6378.521610879203, 6415.530020942064, 6459.773907913201, 6544.901826472606, 6587.604743715392, 6520.217573891164, 6639.468842492685, 6722.630255336004, 6792.388685018372, 6818.318168183142, 6600.53796234259, 6652.700628471827, 6706.932930670826, 6728.259891412039, 6735.25912149673, 6529.347065293433, 6592.208934927839, 6605.1835745170465, 6613.14029176204, 6639.6680165992475, 4953.281774142802, 5014.222795466709, 5050.469700681376, 5055.266986287042, 5083.237514372874, 6628.337166283333, 6630.403263706289, 6721.1598550181225, 6862.553933994274, 6909.654517274217, 6492.350764923659, 6538.738450461929, 6586.045023471665, 6622.178900802318, 6676.465882729467, 6469.967650161719, 6512.185976752906, 6555.344465553597, 6598.142241508765, 6607.603543787388, 6477.0, 6558.508111891531, 6574.572652777554, 6586.979018252178, 6596.505262105457, 6568.343165683585, 6603.7688680895935, 6618.404343609098, 6655.267920528641, 6696.397324240842, 6293.622382657055, 6348.9047664286, 6355.046742988588, 6372.776952806815, 6414.230292364946], "value": 5088.523349249615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.4640322999741, 891.224634567926, 894.6019021535419, 909.5588639509837, 920.9401388909722, 17698.38055668052, 17819.821801781993, 17963.550911227227, 18017.729734053966, 18089.366872159477, 18687.439376818682, 20239.392818215478, 20242.898785506088, 20253.898730506327, 20282.695759563583, 957.4446820843912, 983.1643103362121, 986.2307400227834, 987.0524296675201, 987.4075554667214, 1006.104566935428, 1007.4308015970953, 1018.9949050254738, 1019.0930072235716, 1019.6329321444274, 946.8958414574425, 1029.130384824822, 1036.984445233322, 1042.6142327338857, 1042.9530671119817, 1016.537475448669, 1016.6746641074859, 1025.9948700256489, 1029.2795043469525, 1029.5933106422922, 745.3478206569251, 748.2741740511694, 750.7109762741329, 751.0086685575043, 752.4131177681362, 17888.642227155386, 20155.294564690164, 20327.5934481311, 20377.694334584994, 20399.592008159903, 20850.58298834015, 21136.682949755766, 21347.78652213489, 21394.0, 21435.0, 17780.110994450224, 17886.28454861804, 17961.461156165205, 17999.280028798832, 18125.00312482813, 3699.408094704861, 3723.832427540767, 3731.197792474604, 3734.439834024891, 3737.5328083989502, 139858.99999999898, 140244.0, 141181.0, 141308.0, 141861.0, 17103.914480427517, 17107.315707371567, 17301.56746081358, 17347.21937512815, 17380.130993450275, 31718.524222136686, 32627.67372326294, 32634.0, 32637.673623263938, 32650.836745816596, 8439.324854011664, 8545.487270763773, 8644.913550864536, 8705.042445331008, 8811.691590794291, 4063.4920634920636, 4138.772367519755, 4176.874693759192, 4185.602367775056, 4190.958090419118, 4928.8767780805765, 4934.309196712463, 5345.54562862161, 5460.754266058037, 5468.7265636718, 1132.365875109941, 1156.7108222944264, 1157.0801213035488, 1158.7080405347976, 1160.8955194032578, 651.8924377477758, 654.6334052930374, 661.4807376209652, 670.302884999595, 677.2076670295766, 11566.768664626661, 11580.47887845049, 11928.761424771455, 12899.548515801902, 13039.282839443922, 664.6709878610119, 665.7969319357545, 673.8483841135803, 676.7886379130956, 691.8581690753383, 5854.502367298827, 5860.589758716934, 5920.082387229986, 5935.40645935403, 5939.0, 113174.43412782883, 117016.0, 117880.41059794647, 118608.0, 120819.39590302168, 104598.47700761448, 104724.0, 105970.47014765031, 106573.0, 109107.0, 88531.11468885357, 88825.9999999987, 88952.5552372234, 90290.0, 91064.5446772762, 10731.248812583044, 10827.0, 10865.348079115278, 10995.780084398108, 11028.779424411627, 41180.0, 41906.161876762904, 42779.35830962476, 43062.56937430586, 43516.347254791835, 54211.72894135504, 56228.43771562232, 56434.0, 57455.13817292827, 57884.71057644685, 16523.504294871174, 16623.83376166223, 16631.83368166303, 16729.581760456087, 16908.32366705318, 16727.0, 16777.328906843588, 17287.913560432622, 17363.739543907104, 17370.478885633453, 16533.751993720343, 16581.502554923372, 16815.159242038095, 16835.41076062332, 16911.154442278083, 16649.66700666004, 16662.250198741327, 16764.413245536834, 16887.408940687015, 16950.15249237558, 14897.776533352226, 14917.701645967238, 15041.849581504044, 15066.623334416727, 15220.695586088437, 11899.940500297444, 12131.514739410324, 12427.875721242672, 12463.750724985268, 12600.11799174049, 12224.75550489003, 12248.448819802952, 12363.876361236633, 12467.251964882136, 12523.998080153748], "value": 8979.422795676126, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 107.0, 109.0, 109.0, 108.0, 111.0, 108.0, 115.0, 108.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 121.0, 120.0, 117.0, 123.0, 127.0, 152.0, 120.0, 124.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 170.0, 168.0, 178.0, 172.0, 169.0, 172.0, 166.0, 168.0], "value": 169.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 74.0, 75.0, 89.0, 76.0, 73.0, 76.0, 73.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 79.0, 84.0, 79.0, 80.0, 79.0, 89.0, 80.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 120.0, 115.0, 115.0, 113.0, 121.0, 114.0, 124.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 149.0, 148.0, 149.0, 151.0, 149.0, 152.0, 149.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 100.0, 97.0, 94.0, 95.0, 94.0, 94.0, 95.0, 104.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 52.0, 52.0, 55.0, 58.0, 53.0, 52.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 48.0, 45.0, 42.0, 43.0, 47.0, 37.0, 37.0, 38.0, 37.0], "value": 41.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 83.0, 81.0, 76.0, 77.0, 84.0, 77.0, 86.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 119.0, 127.0, 120.0, 131.0, 118.0, 127.0, 127.0, 116.0, 131.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 169.0, 173.0, 173.0, 175.0, 168.0, 165.0, 169.0, 169.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 68.0, 62.0, 65.0, 63.0, 64.0, 65.0, 68.0], "value": 64.9, "unit": "score"}]}]} 11:23:57 INFO - Return code: 0 11:23:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:57 INFO - # TBPL SUCCESS # 11:23:57 INFO - Running post-action listener: _package_coverage_data 11:23:57 INFO - Running post-action listener: _resource_record_post_action 11:23:57 INFO - [mozharness: 2017-09-08 18:23:57.317931Z] Finished run-tests step (success) 11:23:57 INFO - Running post-run listener: _resource_record_post_run 11:23:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 5554176; Write bytes: 295927808; Read time: 3756; Write time: 160340 11:23:57 INFO - TinderboxPrint: CPU usage
13.3% 11:23:57 INFO - TinderboxPrint: I/O read bytes / time
5,554,176 / 3,756 11:23:57 INFO - TinderboxPrint: I/O write bytes / time
295,927,808 / 160,340 11:23:57 INFO - TinderboxPrint: CPU idle
8,250.8 (86.7%) 11:23:57 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 11:23:57 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12423168; Read time: 0; Write time: 2372 11:23:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5554176; Write bytes: 283107328; Read time: 3756; Write time: 157944 11:23:57 INFO - Running post-run listener: _upload_blobber_files 11:23:57 INFO - Blob upload gear active. 11:23:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23: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 11:23: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'] 11:23: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 11:23:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:04 INFO - (blobuploader) - INFO - Done attempting. 11:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:05 INFO - (blobuploader) - INFO - Done attempting. 11:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:06 INFO - (blobuploader) - INFO - Done attempting. 11:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:07 INFO - (blobuploader) - INFO - Done attempting. 11:24:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:07 INFO - Return code: 0 11:24:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff459e0da5eb84be2bc07ae5ce84f9b6d5546491e7c6407983ddd87fd75a8c202ff52fa3e0eb2a4b3668fbd4dcb654755d9e1a62bb86b1e5ab0ac0b99662c2c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fb9559cae48960682caadfb3a1003f0d1d895907f31f78b5df1755acd777500cd5bb702e901a4a5f16461e0a56eb22854e24d24b02465430c1ff67bbacf05ee", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1906773e852070897a8ae688946ce5ff335d0e4856b87f63da62413cc897ebdfbf0c7183faa1811329d804494566034c8d320cfdcce2cc4ef0cdb5b6f29ba3ee", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12c8e665c508d230d368ccb3079af30f9c10802dba3c45c470cb684dd8600b0a05bffc469b5f8fe6691d9c5a0a64708f3c6eb3427cdbe5653e06d0c5e596617e"} 11:24:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:07 INFO - Contents: 11:24:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff459e0da5eb84be2bc07ae5ce84f9b6d5546491e7c6407983ddd87fd75a8c202ff52fa3e0eb2a4b3668fbd4dcb654755d9e1a62bb86b1e5ab0ac0b99662c2c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fb9559cae48960682caadfb3a1003f0d1d895907f31f78b5df1755acd777500cd5bb702e901a4a5f16461e0a56eb22854e24d24b02465430c1ff67bbacf05ee", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1906773e852070897a8ae688946ce5ff335d0e4856b87f63da62413cc897ebdfbf0c7183faa1811329d804494566034c8d320cfdcce2cc4ef0cdb5b6f29ba3ee", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12c8e665c508d230d368ccb3079af30f9c10802dba3c45c470cb684dd8600b0a05bffc469b5f8fe6691d9c5a0a64708f3c6eb3427cdbe5653e06d0c5e596617e"} 11:24:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:07 INFO - Copying logs to upload dir... 11:24:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.587527 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-08 11:24:07.803459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:07.807454) ========= 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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff459e0da5eb84be2bc07ae5ce84f9b6d5546491e7c6407983ddd87fd75a8c202ff52fa3e0eb2a4b3668fbd4dcb654755d9e1a62bb86b1e5ab0ac0b99662c2c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fb9559cae48960682caadfb3a1003f0d1d895907f31f78b5df1755acd777500cd5bb702e901a4a5f16461e0a56eb22854e24d24b02465430c1ff67bbacf05ee", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1906773e852070897a8ae688946ce5ff335d0e4856b87f63da62413cc897ebdfbf0c7183faa1811329d804494566034c8d320cfdcce2cc4ef0cdb5b6f29ba3ee", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12c8e665c508d230d368ccb3079af30f9c10802dba3c45c470cb684dd8600b0a05bffc469b5f8fe6691d9c5a0a64708f3c6eb3427cdbe5653e06d0c5e596617e"} build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff459e0da5eb84be2bc07ae5ce84f9b6d5546491e7c6407983ddd87fd75a8c202ff52fa3e0eb2a4b3668fbd4dcb654755d9e1a62bb86b1e5ab0ac0b99662c2c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fb9559cae48960682caadfb3a1003f0d1d895907f31f78b5df1755acd777500cd5bb702e901a4a5f16461e0a56eb22854e24d24b02465430c1ff67bbacf05ee", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1906773e852070897a8ae688946ce5ff335d0e4856b87f63da62413cc897ebdfbf0c7183faa1811329d804494566034c8d320cfdcce2cc4ef0cdb5b6f29ba3ee", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12c8e665c508d230d368ccb3079af30f9c10802dba3c45c470cb684dd8600b0a05bffc469b5f8fe6691d9c5a0a64708f3c6eb3427cdbe5653e06d0c5e596617e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:07.835843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:07.841174) ========= 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=3836458cccd887f2d2de3cf1000001de-1504893391.684214-1983639892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:07.920044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:07.920373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:07.920656) ========= ========= Total master_lag: 0.22 =========