builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1505814926.93 results: success (0) revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:26.932345) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:26.932787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:26.933140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:26.969367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:26.969733) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 02:55:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2017-09-19 02:55:27 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.114036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.114371) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019235 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.180109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.180448) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 02:55:27,230 truncating revision to first 12 chars 2017-09-19 02:55:27,230 Setting DEBUG logging. 2017-09-19 02:55:27,230 attempt 1/10 2017-09-19 02:55:27,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c12af6fd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 02:55:27,605 unpacking tar archive at: mozilla-central-7c12af6fd620/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.907716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.908036) ========= script_repo_revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.908479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.908805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 02:55:27.931021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-19 02:55:27.931394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:55:28 INFO - MultiFileLogger online at 20170919 02:55:28 in /builds/slave/test 02:55:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:28 INFO - {'append_to_log': False, 02:55:28 INFO - 'base_work_dir': '/builds/slave/test', 02:55:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:28 INFO - 'branch': 'Firefox-Non-PGO', 02:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:28 INFO - 'code_coverage': False, 02:55:28 INFO - 'config_files': ('talos/linux_config.py',), 02:55:28 INFO - 'default_actions': ('clobber', 02:55:28 INFO - 'read-buildbot-config', 02:55:28 INFO - 'download-and-extract', 02:55:28 INFO - 'populate-webroot', 02:55:28 INFO - 'create-virtualenv', 02:55:28 INFO - 'install', 02:55:28 INFO - 'setup-mitmproxy', 02:55:28 INFO - 'run-tests'), 02:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:28 INFO - 'disable_ccov_upload': False, 02:55:28 INFO - 'disable_stylo': False, 02:55:28 INFO - 'download_minidump_stackwalk': True, 02:55:28 INFO - 'download_symbols': 'ondemand', 02:55:28 INFO - 'enable_stylo': False, 02:55:28 INFO - 'enable_webrender': False, 02:55:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:28 INFO - 'gecko_profile': False, 02:55:28 INFO - 'gecko_profile_interval': 0, 02:55:28 INFO - 'installer_path': 'installer.exe', 02:55:28 INFO - 'log_level': 'info', 02:55:28 INFO - 'log_name': 'talos', 02:55:28 INFO - 'log_to_console': True, 02:55:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:55:28 INFO - 'opt_config_files': (), 02:55:28 INFO - 'pip_index': False, 02:55:28 INFO - 'suite': 'dromaeojs-e10s', 02:55:28 INFO - 'system_bits': '32', 02:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:28 INFO - 'title': 'talos-linux64-ix-012', 02:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:28 INFO - 'use_talos_json': True, 02:55:28 INFO - 'verify': 'False', 02:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:28 INFO - 'work_dir': 'build'} 02:55:28 INFO - [mozharness: 2017-09-19 09:55:28.125063Z] Running clobber step. 02:55:28 INFO - Running pre-action listener: _resource_record_pre_action 02:55:28 INFO - Running main action method: clobber 02:55:28 INFO - rmtree: /builds/slave/test/build 02:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:29 INFO - Running post-action listener: _resource_record_post_action 02:55:29 INFO - [mozharness: 2017-09-19 09:55:29.640636Z] Finished clobber step (success) 02:55:29 INFO - [mozharness: 2017-09-19 09:55:29.640733Z] Running read-buildbot-config step. 02:55:29 INFO - Running pre-action listener: _resource_record_pre_action 02:55:29 INFO - Running main action method: read_buildbot_config 02:55:29 INFO - Using buildbot properties: 02:55:29 INFO - { 02:55:29 INFO - "project": "", 02:55:29 INFO - "product": "firefox", 02:55:29 INFO - "who": "archaeopteryx@coole-files.de", 02:55:29 INFO - "installer_path": "public/build/target.tar.bz2", 02:55:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:55:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:55:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:55:29 INFO - "stage_platform": "linux64", 02:55:29 INFO - "basedir": "/builds/slave/test", 02:55:29 INFO - "buildnumber": 1157, 02:55:29 INFO - "platform": "ubuntu64_hw", 02:55:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:55:29 INFO - "slavebuilddir": "test", 02:55:29 INFO - "taskId": "NqJFxRNqSaSuViwHDKvfpw", 02:55:29 INFO - "branch": "mozilla-central", 02:55:29 INFO - "script_repo_revision": "production", 02:55:29 INFO - "revision": "7c12af6fd620adc74e9dfb622d17966bdebdf2ac", 02:55:29 INFO - "slavename": "talos-linux64-ix-012", 02:55:29 INFO - "repo_path": "mozilla-central" 02:55:29 INFO - } 02:55:29 INFO - Finding installer, test and symbols from parent task. 02:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqJFxRNqSaSuViwHDKvfpw'}, attempt #1 02:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqJFxRNqSaSuViwHDKvfpw'}, attempt #1 02:55:30 INFO - Task dependencies: E2iwetAjQBK55x0sv57OwA 02:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA'}, attempt #1 02:55:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json 02:55:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip 02:55:31 INFO - Running post-action listener: _resource_record_post_action 02:55:31 INFO - [mozharness: 2017-09-19 09:55:31.273180Z] Finished read-buildbot-config step (success) 02:55:31 INFO - [mozharness: 2017-09-19 09:55:31.273443Z] Running download-and-extract step. 02:55:31 INFO - Running pre-action listener: _resource_record_pre_action 02:55:31 INFO - Running main action method: download_and_extract 02:55:31 INFO - mkdir: /builds/slave/test/build/tests 02:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:31 INFO - trying https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json 02:55:31 INFO - Downloading https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:55:31 INFO - Downloaded 989 bytes. 02:55:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:55:31 INFO - Using the following test package requirements: 02:55:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:55:31 INFO - u'common': [u'target.common.tests.zip'], 02:55:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:55:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:55:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:55:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:55:31 INFO - u'mozbase': [u'target.common.tests.zip'], 02:55:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:55:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:55:31 INFO - u'web-platform': [u'target.common.tests.zip', 02:55:31 INFO - u'target.web-platform.tests.tar.gz'], 02:55:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:55:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:55:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip 02:55:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:31 INFO - Fetch https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.common.tests.zip into memory 02:55:34 INFO - Content-Length response header: 54731598 02:55:34 INFO - Bytes received: 54731598 02:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip 02:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.talos.tests.zip into memory 02:55:46 INFO - Content-Length response header: 14508787 02:55:46 INFO - Bytes received: 14508787 02:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:47 INFO - trying https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:47 INFO - Downloading https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:55:49 INFO - Downloaded 61520244 bytes. 02:55:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:49 INFO - mkdir: /builds/slave/test/properties 02:55:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:49 INFO - Contents: 02:55:49 INFO - build_url:https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 02:55:49 INFO - Running post-action listener: _resource_record_post_action 02:55:49 INFO - Running post-action listener: find_tests_for_verification 02:55:49 INFO - Running post-action listener: set_extra_try_arguments 02:55:49 INFO - [mozharness: 2017-09-19 09:55:49.808114Z] Finished download-and-extract step (success) 02:55:49 INFO - [mozharness: 2017-09-19 09:55:49.808251Z] Running populate-webroot step. 02:55:49 INFO - Running pre-action listener: _resource_record_pre_action 02:55:49 INFO - Running main action method: populate_webroot 02:55:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['tresize', 02:55:49 INFO - 'tcanvasmark']}, 02:55:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['dromaeo_css', 02:55:49 INFO - 'kraken']}, 02:55:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'tests': ['damp', 'tps']}, 02:55:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['damp', 'tps']}, 02:55:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['dromaeo_dom']}, 02:55:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:55:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['basic_compositor_video', 02:55:49 INFO - 'glvideo']}, 02:55:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['ts_paint_webext', 02:55:49 INFO - 'tp5o_webext']}, 02:55:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:49 INFO - 'ts_paint', 02:55:49 INFO - 'tpaint', 02:55:49 INFO - 'sessionrestore', 02:55:49 INFO - 'sessionrestore_many_windows', 02:55:49 INFO - 'sessionrestore_no_auto_restore', 02:55:49 INFO - 'tabpaint']}, 02:55:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['a11yr', 02:55:49 INFO - 'ts_paint', 02:55:49 INFO - 'tpaint', 02:55:49 INFO - 'sessionrestore', 02:55:49 INFO - 'sessionrestore_many_windows', 02:55:49 INFO - 'sessionrestore_no_auto_restore', 02:55:49 INFO - 'tabpaint']}, 02:55:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:55:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:55:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['perf_reftest_singletons']}, 02:55:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['bloom_basic']}, 02:55:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:49 INFO - 'tsvgr_opacity', 02:55:49 INFO - 'tart', 02:55:49 INFO - 'tscrollx', 02:55:49 INFO - 'tsvg_static']}, 02:55:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['tsvgx', 02:55:49 INFO - 'tsvgr_opacity', 02:55:49 INFO - 'tart', 02:55:49 INFO - 'tscrollx', 02:55:49 INFO - 'tsvg_static']}, 02:55:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo'], 02:55:49 INFO - 'tests': ['tp5o']}, 02:55:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:49 INFO - 'talos_options': ['--mitmproxy', 02:55:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:49 INFO - '--firstNonBlankPaint'], 02:55:49 INFO - 'tests': ['tp6_google', 02:55:49 INFO - 'tp6_youtube', 02:55:49 INFO - 'tp6_amazon', 02:55:49 INFO - 'tp6_facebook']}, 02:55:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo', 02:55:49 INFO - '--mitmproxy', 02:55:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:49 INFO - '--firstNonBlankPaint'], 02:55:49 INFO - 'tests': ['tp6_google', 02:55:49 INFO - 'tp6_youtube', 02:55:49 INFO - 'tp6_amazon', 02:55:49 INFO - 'tp6_facebook']}, 02:55:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:49 INFO - 'talos_options': ['--stylo-threads=1', 02:55:49 INFO - '--mitmproxy', 02:55:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:49 INFO - '--firstNonBlankPaint'], 02:55:49 INFO - 'tests': ['tp6_google', 02:55:49 INFO - 'tp6_youtube', 02:55:49 INFO - 'tp6_amazon', 02:55:49 INFO - 'tp6_facebook']}, 02:55:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--xperf_path', 02:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:49 INFO - 'tests': ['tp5n']}, 02:55:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:55:49 INFO - 'talos_options': ['--disable-stylo', 02:55:49 INFO - '--xperf_path', 02:55:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:49 INFO - 'tests': ['tp5n']}}} 02:55:49 INFO - Running post-action listener: _resource_record_post_action 02:55:49 INFO - [mozharness: 2017-09-19 09:55:49.825216Z] Finished populate-webroot step (success) 02:55:49 INFO - [mozharness: 2017-09-19 09:55:49.825351Z] Running create-virtualenv step. 02:55:49 INFO - Running pre-action listener: _resource_record_pre_action 02:55:49 INFO - Running main action method: create_virtualenv 02:55:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:55:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:55:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:50 INFO - Installing pip...............done. 02:55:50 INFO - Return code: 0 02:55:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:50 INFO - Reading from file tmpfile_stdout 02:55:50 INFO - Output received: 02:55:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:55:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:50 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:50 INFO - Using env: {'DISPLAY': ':0', 02:55:50 INFO - 'HOME': '/home/cltbld', 02:55:50 INFO - 'LANG': 'en_US.UTF-8', 02:55:50 INFO - 'LANGUAGE': 'en_US:en', 02:55:50 INFO - 'LOGNAME': 'cltbld', 02:55:50 INFO - 'MAIL': '/var/mail/cltbld', 02:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:50 INFO - 'MOZ_NO_REMOTE': '1', 02:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:50 INFO - 'NO_EM_RESTART': '1', 02:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:50 INFO - 'PWD': '/builds/slave/test', 02:55:50 INFO - 'SHELL': '/bin/bash', 02:55:50 INFO - 'SHLVL': '1', 02:55:50 INFO - 'TERM': 'linux', 02:55:50 INFO - 'TMOUT': '86400', 02:55:50 INFO - 'USER': 'cltbld', 02:55:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:50 INFO - '_': '/tools/buildbot/bin/python'} 02:55:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:55:52 INFO - Downloading/unpacking pip>=1.5 02:55:52 INFO - Running setup.py egg_info for package pip 02:55:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:52 INFO - Installing collected packages: pip 02:55:52 INFO - Found existing installation: pip 1.1 02:55:52 INFO - Uninstalling pip: 02:55:52 INFO - Successfully uninstalled pip 02:55:52 INFO - Running setup.py install for pip 02:55:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:55:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:55:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:55:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:55:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:55:52 INFO - Successfully installed pip 02:55:52 INFO - Cleaning up... 02:55:52 INFO - Return code: 0 02:55:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:55:52 INFO - Using env: {'DISPLAY': ':0', 02:55:52 INFO - 'HOME': '/home/cltbld', 02:55:52 INFO - 'LANG': 'en_US.UTF-8', 02:55:52 INFO - 'LANGUAGE': 'en_US:en', 02:55:52 INFO - 'LOGNAME': 'cltbld', 02:55:52 INFO - 'MAIL': '/var/mail/cltbld', 02:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:52 INFO - 'MOZ_NO_REMOTE': '1', 02:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:52 INFO - 'NO_EM_RESTART': '1', 02:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:52 INFO - 'PWD': '/builds/slave/test', 02:55:52 INFO - 'SHELL': '/bin/bash', 02:55:52 INFO - 'SHLVL': '1', 02:55:52 INFO - 'TERM': 'linux', 02:55:52 INFO - 'TMOUT': '86400', 02:55:52 INFO - 'USER': 'cltbld', 02:55:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:52 INFO - '_': '/tools/buildbot/bin/python'} 02:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:52 INFO - Downloading/unpacking psutil>=3.1.1 02:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:53 INFO - Installing collected packages: psutil 02:55:53 INFO - Running setup.py install for psutil 02:55:53 INFO - building 'psutil._psutil_linux' extension 02:55:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:55:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:55:53 INFO - building 'psutil._psutil_posix' extension 02:55:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:55:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:55:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:53 INFO - Successfully installed psutil 02:55:53 INFO - Cleaning up... 02:55:53 INFO - Return code: 0 02:55:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:55:54 INFO - Using env: {'DISPLAY': ':0', 02:55:54 INFO - 'HOME': '/home/cltbld', 02:55:54 INFO - 'LANG': 'en_US.UTF-8', 02:55:54 INFO - 'LANGUAGE': 'en_US:en', 02:55:54 INFO - 'LOGNAME': 'cltbld', 02:55:54 INFO - 'MAIL': '/var/mail/cltbld', 02:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:54 INFO - 'MOZ_NO_REMOTE': '1', 02:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:54 INFO - 'NO_EM_RESTART': '1', 02:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:54 INFO - 'PWD': '/builds/slave/test', 02:55:54 INFO - 'SHELL': '/bin/bash', 02:55:54 INFO - 'SHLVL': '1', 02:55:54 INFO - 'TERM': 'linux', 02:55:54 INFO - 'TMOUT': '86400', 02:55:54 INFO - 'USER': 'cltbld', 02:55:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:54 INFO - '_': '/tools/buildbot/bin/python'} 02:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:55:55 INFO - Installing collected packages: mozsystemmonitor 02:55:55 INFO - Running setup.py install for mozsystemmonitor 02:55:55 INFO - Successfully installed mozsystemmonitor 02:55:55 INFO - Cleaning up... 02:55:56 INFO - Return code: 0 02:55:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:56 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:55:56 INFO - Using env: {'DISPLAY': ':0', 02:55:56 INFO - 'HOME': '/home/cltbld', 02:55:56 INFO - 'LANG': 'en_US.UTF-8', 02:55:56 INFO - 'LANGUAGE': 'en_US:en', 02:55:56 INFO - 'LOGNAME': 'cltbld', 02:55:56 INFO - 'MAIL': '/var/mail/cltbld', 02:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:56 INFO - 'MOZ_NO_REMOTE': '1', 02:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:56 INFO - 'NO_EM_RESTART': '1', 02:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:56 INFO - 'PWD': '/builds/slave/test', 02:55:56 INFO - 'SHELL': '/bin/bash', 02:55:56 INFO - 'SHLVL': '1', 02:55:56 INFO - 'TERM': 'linux', 02:55:56 INFO - 'TMOUT': '86400', 02:55:56 INFO - 'USER': 'cltbld', 02:55:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:56 INFO - '_': '/tools/buildbot/bin/python'} 02:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:57 INFO - warning: no files found matching '*.txt' 02:55:57 INFO - no previously-included directories found matching 'build' 02:55:57 INFO - no previously-included directories found matching 'dist' 02:55:57 INFO - no previously-included directories found matching '.git*' 02:55:57 INFO - Installing collected packages: jsonschema, functools32 02:55:57 INFO - Running setup.py install for functools32 02:55:58 INFO - warning: no files found matching '*.txt' 02:55:58 INFO - no previously-included directories found matching 'build' 02:55:58 INFO - no previously-included directories found matching 'dist' 02:55:58 INFO - no previously-included directories found matching '.git*' 02:55:58 INFO - Successfully installed jsonschema functools32 02:55:58 INFO - Cleaning up... 02:55:58 INFO - Return code: 0 02:55:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:55:58 INFO - Using env: {'DISPLAY': ':0', 02:55:58 INFO - 'HOME': '/home/cltbld', 02:55:58 INFO - 'LANG': 'en_US.UTF-8', 02:55:58 INFO - 'LANGUAGE': 'en_US:en', 02:55:58 INFO - 'LOGNAME': 'cltbld', 02:55:58 INFO - 'MAIL': '/var/mail/cltbld', 02:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:58 INFO - 'MOZ_NO_REMOTE': '1', 02:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:58 INFO - 'NO_EM_RESTART': '1', 02:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:58 INFO - 'PWD': '/builds/slave/test', 02:55:58 INFO - 'SHELL': '/bin/bash', 02:55:58 INFO - 'SHLVL': '1', 02:55:58 INFO - 'TERM': 'linux', 02:55:58 INFO - 'TMOUT': '86400', 02:55:58 INFO - 'USER': 'cltbld', 02:55:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:58 INFO - '_': '/tools/buildbot/bin/python'} 02:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:55:58 INFO - Cleaning up... 02:55:58 INFO - Return code: 0 02:55:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:58 INFO - Using env: {'DISPLAY': ':0', 02:55:58 INFO - 'HOME': '/home/cltbld', 02:55:58 INFO - 'LANG': 'en_US.UTF-8', 02:55:58 INFO - 'LANGUAGE': 'en_US:en', 02:55:58 INFO - 'LOGNAME': 'cltbld', 02:55:58 INFO - 'MAIL': '/var/mail/cltbld', 02:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:58 INFO - 'MOZ_NO_REMOTE': '1', 02:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:58 INFO - 'NO_EM_RESTART': '1', 02:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:58 INFO - 'PWD': '/builds/slave/test', 02:55:58 INFO - 'SHELL': '/bin/bash', 02:55:58 INFO - 'SHLVL': '1', 02:55:58 INFO - 'TERM': 'linux', 02:55:58 INFO - 'TMOUT': '86400', 02:55:58 INFO - 'USER': 'cltbld', 02:55:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:58 INFO - '_': '/tools/buildbot/bin/python'} 02:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - Downloading docopt-0.6.1.tar.gz 02:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:00 INFO - Running setup.py install for blobuploader 02:56:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:00 INFO - Running setup.py install for requests 02:56:00 INFO - Running setup.py install for docopt 02:56:00 INFO - Successfully installed blobuploader requests docopt 02:56:00 INFO - Cleaning up... 02:56:00 INFO - Return code: 0 02:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56: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')]} 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:00 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:00 INFO - Using env: {'DISPLAY': ':0', 02:56:00 INFO - 'HOME': '/home/cltbld', 02:56:00 INFO - 'LANG': 'en_US.UTF-8', 02:56:00 INFO - 'LANGUAGE': 'en_US:en', 02:56:00 INFO - 'LOGNAME': 'cltbld', 02:56:00 INFO - 'MAIL': '/var/mail/cltbld', 02:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:00 INFO - 'MOZ_NO_REMOTE': '1', 02:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:00 INFO - 'NO_EM_RESTART': '1', 02:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:00 INFO - 'PWD': '/builds/slave/test', 02:56:00 INFO - 'SHELL': '/bin/bash', 02:56:00 INFO - 'SHLVL': '1', 02:56:00 INFO - 'TERM': 'linux', 02:56:00 INFO - 'TMOUT': '86400', 02:56:00 INFO - 'USER': 'cltbld', 02:56:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:00 INFO - '_': '/tools/buildbot/bin/python'} 02:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:01 INFO - Running setup.py (path:/tmp/pip-Mkzg7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:01 INFO - Running setup.py (path:/tmp/pip-_Pexso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:01 INFO - Running setup.py (path:/tmp/pip-N5FYGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:01 INFO - Running setup.py (path:/tmp/pip-MAvR2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:01 INFO - Running setup.py (path:/tmp/pip-_w7mZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:01 INFO - Running setup.py (path:/tmp/pip-VXXVNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:01 INFO - Running setup.py (path:/tmp/pip-FU_abX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:01 INFO - Running setup.py (path:/tmp/pip-_2PgJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:01 INFO - Running setup.py (path:/tmp/pip-aWN6wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:01 INFO - Running setup.py (path:/tmp/pip-F8ZDC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:01 INFO - Running setup.py (path:/tmp/pip-416W4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:01 INFO - Running setup.py (path:/tmp/pip-xErD3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:01 INFO - Running setup.py (path:/tmp/pip-Jk69gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:01 INFO - Running setup.py (path:/tmp/pip-2XmKmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:02 INFO - Running setup.py (path:/tmp/pip-8m6y3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:02 INFO - Running setup.py (path:/tmp/pip-neJbrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:02 INFO - Running setup.py (path:/tmp/pip-OzLEj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:02 INFO - Running setup.py install for manifestparser 02:56:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozcrash 02:56:02 INFO - Running setup.py install for mozdebug 02:56:02 INFO - Running setup.py install for mozdevice 02:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozfile 02:56:02 INFO - Running setup.py install for mozhttpd 02:56:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozinfo 02:56:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozInstall 02:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozleak 02:56:03 INFO - Running setup.py install for mozlog 02:56:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for moznetwork 02:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozprocess 02:56:03 INFO - Running setup.py install for mozprofile 02:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozrunner 02:56:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Running setup.py install for mozscreenshot 02:56:03 INFO - Running setup.py install for moztest 02:56:03 INFO - Running setup.py install for mozversion 02:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:04 INFO - Cleaning up... 02:56:04 INFO - Return code: 0 02:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:04 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:04 INFO - Using env: {'DISPLAY': ':0', 02:56:04 INFO - 'HOME': '/home/cltbld', 02:56:04 INFO - 'LANG': 'en_US.UTF-8', 02:56:04 INFO - 'LANGUAGE': 'en_US:en', 02:56:04 INFO - 'LOGNAME': 'cltbld', 02:56:04 INFO - 'MAIL': '/var/mail/cltbld', 02:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:04 INFO - 'MOZ_NO_REMOTE': '1', 02:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:04 INFO - 'NO_EM_RESTART': '1', 02:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:04 INFO - 'PWD': '/builds/slave/test', 02:56:04 INFO - 'SHELL': '/bin/bash', 02:56:04 INFO - 'SHLVL': '1', 02:56:04 INFO - 'TERM': 'linux', 02:56:04 INFO - 'TMOUT': '86400', 02:56:04 INFO - 'USER': 'cltbld', 02:56:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:04 INFO - '_': '/tools/buildbot/bin/python'} 02:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:04 INFO - Running setup.py (path:/tmp/pip-dl42OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:04 INFO - Running setup.py (path:/tmp/pip-_0bcJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:04 INFO - Running setup.py (path:/tmp/pip-Nj_RWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:04 INFO - Running setup.py (path:/tmp/pip-a6rKlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:04 INFO - Running setup.py (path:/tmp/pip-a7oy40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:04 INFO - Running setup.py (path:/tmp/pip-aMe8vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:04 INFO - Running setup.py (path:/tmp/pip-dargaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:04 INFO - Running setup.py (path:/tmp/pip-SyU6C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:04 INFO - Running setup.py (path:/tmp/pip-yXvnwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:04 INFO - Running setup.py (path:/tmp/pip-7thl0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:04 INFO - Running setup.py (path:/tmp/pip-oIZ1Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:05 INFO - Running setup.py (path:/tmp/pip-bbeR7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:05 INFO - Running setup.py (path:/tmp/pip-oPtu7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:05 INFO - Running setup.py (path:/tmp/pip-qB2eqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:05 INFO - Running setup.py (path:/tmp/pip-qSBmAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:05 INFO - Running setup.py (path:/tmp/pip-aRDR8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:05 INFO - Running setup.py (path:/tmp/pip-bOLfZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:56:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - Downloading blessings-1.6.tar.gz 02:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:06 INFO - Installing collected packages: blessings 02:56:06 INFO - Running setup.py install for blessings 02:56:06 INFO - Successfully installed blessings 02:56:06 INFO - Cleaning up... 02:56:06 INFO - Return code: 0 02:56:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:07 INFO - Reading from file tmpfile_stdout 02:56:07 INFO - Current package versions: 02:56:07 INFO - argparse == 1.2.1 02:56:07 INFO - blessings == 1.6 02:56:07 INFO - blobuploader == 1.2.4 02:56:07 INFO - docopt == 0.6.1 02:56:07 INFO - functools32 == 3.2.3-2 02:56:07 INFO - jsonschema == 2.5.1 02:56:07 INFO - manifestparser == 1.1 02:56:07 INFO - mozInstall == 1.13 02:56:07 INFO - mozcrash == 1.0 02:56:07 INFO - mozdebug == 0.1 02:56:07 INFO - mozdevice == 0.51 02:56:07 INFO - mozfile == 1.2 02:56:07 INFO - mozhttpd == 0.7 02:56:07 INFO - mozinfo == 0.10 02:56:07 INFO - mozleak == 0.1 02:56:07 INFO - mozlog == 3.5 02:56:07 INFO - moznetwork == 0.27 02:56:07 INFO - mozprocess == 0.25 02:56:07 INFO - mozprofile == 0.28 02:56:07 INFO - mozrunner == 6.13 02:56:07 INFO - mozscreenshot == 0.1 02:56:07 INFO - mozsystemmonitor == 0.3 02:56:07 INFO - moztest == 0.8 02:56:07 INFO - mozversion == 1.4 02:56:07 INFO - psutil == 3.1.1 02:56:07 INFO - requests == 1.2.3 02:56:07 INFO - wsgiref == 0.1.2 02:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:07 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:07 INFO - Using env: {'DISPLAY': ':0', 02:56:07 INFO - 'HOME': '/home/cltbld', 02:56:07 INFO - 'LANG': 'en_US.UTF-8', 02:56:07 INFO - 'LANGUAGE': 'en_US:en', 02:56:07 INFO - 'LOGNAME': 'cltbld', 02:56:07 INFO - 'MAIL': '/var/mail/cltbld', 02:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:07 INFO - 'MOZ_NO_REMOTE': '1', 02:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:07 INFO - 'NO_EM_RESTART': '1', 02:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:07 INFO - 'PWD': '/builds/slave/test', 02:56:07 INFO - 'SHELL': '/bin/bash', 02:56:07 INFO - 'SHLVL': '1', 02:56:07 INFO - 'TERM': 'linux', 02:56:07 INFO - 'TMOUT': '86400', 02:56:07 INFO - 'USER': 'cltbld', 02:56:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:07 INFO - '_': '/tools/buildbot/bin/python'} 02:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:56:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:08 INFO - Installing collected packages: simplejson 02:56:08 INFO - Running setup.py install for simplejson 02:56:08 INFO - building 'simplejson._speedups' extension 02:56:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:56:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:56:09 INFO - Successfully installed simplejson 02:56:09 INFO - Cleaning up... 02:56:09 INFO - Return code: 0 02:56:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:09 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 0x11921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:56:09 INFO - Using env: {'DISPLAY': ':0', 02:56:09 INFO - 'HOME': '/home/cltbld', 02:56:09 INFO - 'LANG': 'en_US.UTF-8', 02:56:09 INFO - 'LANGUAGE': 'en_US:en', 02:56:09 INFO - 'LOGNAME': 'cltbld', 02:56:09 INFO - 'MAIL': '/var/mail/cltbld', 02:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:09 INFO - 'MOZ_NO_REMOTE': '1', 02:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:09 INFO - 'NO_EM_RESTART': '1', 02:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:09 INFO - 'PWD': '/builds/slave/test', 02:56:09 INFO - 'SHELL': '/bin/bash', 02:56:09 INFO - 'SHLVL': '1', 02:56:09 INFO - 'TERM': 'linux', 02:56:09 INFO - 'TMOUT': '86400', 02:56:09 INFO - 'USER': 'cltbld', 02:56:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:09 INFO - '_': '/tools/buildbot/bin/python'} 02:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:09 INFO - Cleaning up... 02:56:09 INFO - Return code: 0 02:56:09 INFO - Running post-action listener: _resource_record_post_action 02:56:09 INFO - Running post-action listener: _start_resource_monitoring 02:56:09 INFO - Starting resource monitoring. 02:56:09 INFO - [mozharness: 2017-09-19 09:56:09.785976Z] Finished create-virtualenv step (success) 02:56:09 INFO - [mozharness: 2017-09-19 09:56:09.786442Z] Running install step. 02:56:09 INFO - Running pre-action listener: _resource_record_pre_action 02:56:09 INFO - Running main action method: install 02:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:10 INFO - Reading from file tmpfile_stdout 02:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:10 INFO - Reading from file tmpfile_stdout 02:56:10 INFO - Output received: 02:56:10 INFO - Usage: mozinstall [options] installer 02:56:10 INFO - Options: 02:56:10 INFO - -h, --help show this help message and exit 02:56:10 INFO - -d DEST, --destination=DEST 02:56:10 INFO - Directory to install application into. [default: 02:56:10 INFO - "/builds/slave/test"] 02:56:10 INFO - --app=APP Application being installed. [default: firefox] 02:56:10 INFO - mkdir: /builds/slave/test/build/application 02:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:56:27 INFO - Reading from file tmpfile_stdout 02:56:27 INFO - Output received: 02:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:56:27 INFO - Running post-action listener: _resource_record_post_action 02:56:27 INFO - [mozharness: 2017-09-19 09:56:27.923577Z] Finished install step (success) 02:56:27 INFO - [mozharness: 2017-09-19 09:56:27.923827Z] Running setup-mitmproxy step. 02:56:27 INFO - Running pre-action listener: _resource_record_pre_action 02:56:27 INFO - Running main action method: setup_mitmproxy 02:56:27 INFO - Skipping: mitmproxy is not required 02:56:27 INFO - Running post-action listener: _resource_record_post_action 02:56:27 INFO - [mozharness: 2017-09-19 09:56:27.924958Z] Finished setup-mitmproxy step (success) 02:56:27 INFO - [mozharness: 2017-09-19 09:56:27.925180Z] Running run-tests step. 02:56:27 INFO - Running pre-action listener: _resource_record_pre_action 02:56:27 INFO - Running pre-action listener: _set_gcov_prefix 02:56:27 INFO - Running main action method: run_tests 02:56:27 WARNING - Try message not found. 02:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:27 INFO - Python 2.7.3 02:56:27 INFO - Return code: 0 02:56:27 INFO - grabbing minidump binary from tooltool 02:56: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')]} 02:56:27 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 0x1502090>, '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 0x1502d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:56:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:56:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:28 INFO - Return code: 0 02:56:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:56:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:28 INFO - ENV: RUST_BACKTRACE is now full 02:56:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:56:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:56:28 INFO - Using env: {'DISPLAY': ':0', 02:56:28 INFO - 'HOME': '/home/cltbld', 02:56:28 INFO - 'LANG': 'en_US.UTF-8', 02:56:28 INFO - 'LANGUAGE': 'en_US:en', 02:56:28 INFO - 'LOGNAME': 'cltbld', 02:56:28 INFO - 'MAIL': '/var/mail/cltbld', 02:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:28 INFO - 'MOZ_NO_REMOTE': '1', 02:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:28 INFO - 'NO_EM_RESTART': '1', 02:56:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:28 INFO - 'PWD': '/builds/slave/test', 02:56:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:28 INFO - 'RUST_BACKTRACE': 'full', 02:56:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:28 INFO - 'SHELL': '/bin/bash', 02:56:28 INFO - 'SHLVL': '1', 02:56:28 INFO - 'TERM': 'linux', 02:56:28 INFO - 'TMOUT': '86400', 02:56:28 INFO - 'USER': 'cltbld', 02:56:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:28 INFO - '_': '/tools/buildbot/bin/python'} 02:56:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:56:28 INFO - mozversion application_buildid: 20170919090857 02:56:28 INFO - mozversion application_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 02:56:28 INFO - mozversion application_display_name: Nightly 02:56:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:28 INFO - mozversion application_name: Firefox 02:56:28 INFO - mozversion application_remotingname: firefox 02:56:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:28 INFO - mozversion application_vendor: Mozilla 02:56:28 INFO - mozversion application_version: 57.0a1 02:56:28 INFO - mozversion platform_buildid: 20170919090857 02:56:28 INFO - mozversion platform_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 02:56:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:28 INFO - mozversion platform_version: 57.0a1 02:56:28 INFO - using testdate: 1505814988 02:56:28 INFO - actual date: 1505814988 02:56:28 INFO - starting webserver on 'localhost:37542' 02:56:28 INFO - SUITE-START | Running 2 tests 02:56:28 INFO - TEST-START | dromaeo_css 02:56:28 INFO - Initialising browser for dromaeo_css test... 02:56:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37542/getInfo.html -profile /tmp/tmplMZLiv/profile 02:56:28 INFO - TEST-INFO | started process 13981 (/builds/slave/test/build/application/firefox/firefox http://localhost:37542/getInfo.html) 02:56:32 INFO - TEST-INFO | 13981: exit 0 02:56:33 INFO - Browser initialized. 02:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:33 INFO - Using env: {'DISPLAY': ':0', 02:56:33 INFO - 'HOME': '/home/cltbld', 02:56:33 INFO - 'JSGC_DISABLE_POISONING': '1', 02:56:33 INFO - 'LANG': 'en_US.UTF-8', 02:56:33 INFO - 'LANGUAGE': 'en_US:en', 02:56:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:56:33 INFO - 'LOGNAME': 'cltbld', 02:56:33 INFO - 'MAIL': '/var/mail/cltbld', 02:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:33 INFO - 'MOZ_CRASHREPORTER': '1', 02:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:56:33 INFO - 'MOZ_NO_REMOTE': '1', 02:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:33 INFO - 'NO_EM_RESTART': '1', 02:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:33 INFO - 'PWD': '/builds/slave/test', 02:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:33 INFO - 'RUST_BACKTRACE': 'full', 02:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:33 INFO - 'SHELL': '/bin/bash', 02:56:33 INFO - 'SHLVL': '1', 02:56:33 INFO - 'TERM': 'linux', 02:56:33 INFO - 'TMOUT': '86400', 02:56:33 INFO - 'USER': 'cltbld', 02:56:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 02:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:33 INFO - '_': '/tools/buildbot/bin/python'} 02:56:33 INFO - TEST-INFO | started process 14212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMZLiv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:34 INFO - PID 14212 | 02:56:34 INFO - PID 14212 | (/builds/slave/test/build/application/firefox/firefox:14261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:56:34 INFO - PID 14212 | 02:56:44 INFO - PID 14212 | RSS: Main: 156622848 02:56:44 INFO - PID 14212 | 02:59:41 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37542/tests/dromaeo/cssquery-ext.html) 02:59:42 INFO - PID 14212 | RSS: Main: 156270592 02:59:42 INFO - PID 14212 | 03:02:44 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-ext.html (next: http://localhost:37542/tests/dromaeo/cssquery-jquery.html) 03:02:44 INFO - PID 14212 | RSS: Main: 156233728 03:02:44 INFO - PID 14212 | 03:05:46 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37542/tests/dromaeo/cssquery-mootools.html) 03:05:47 INFO - PID 14212 | RSS: Main: 158375936 03:05:47 INFO - PID 14212 | 03:08:49 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37542/tests/dromaeo/cssquery-prototype.html) 03:08:49 INFO - PID 14212 | RSS: Main: 157057024 03:08:49 INFO - PID 14212 | 03:11:52 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37542/tests/dromaeo/cssquery-yui.html) 03:11:53 INFO - PID 14212 | RSS: Main: 158400512 03:11:53 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | Cycle 1(1): loaded http://localhost:37542/tests/dromaeo/cssquery-yui.html (next: http://localhost:37542/tests/dromaeo/cssquery-dojo.html) 03:14:55 INFO - PID 14212 | RSS: Main: 160509952 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | __start_tp_report 03:14:55 INFO - PID 14212 | _x_x_mozilla_page_load 03:14:55 INFO - PID 14212 | _x_x_mozilla_page_load_details 03:14:55 INFO - PID 14212 | |i|pagename|runs| 03:14:55 INFO - PID 14212 | |0;dojo.html;3113.3150706844494;3134.2477805326716;3138.1370123216097;3138.639056508502;3144.842757862107;6097.085437184424;6259.405356491137;6263.655498947556;6296.811095667132;6393.0410438434255;6167.568270221086;6184.319724830265;6217.689115544216;6243.406876346739;6261.780837670683;5708.172315014331;5709.743061562219;5750.942490575083;5760.510356619692;5842.737076831553;5840.415958404168;5841.64950102993;5854.824355269348;5862.149988251701;5891.469767720904;99.68034518202253;5739.110437882135;5814.040683287274;5820.068788993762;5824.388439213885;5613.46672066153;5644.04051311274;5644.8024319148635;5691.658500489983;5783;5666.206731057655;5683.147527870811;5747.511461525775;5748.2527271454865;5759.308882934033;6208;6224.377562243784;6236.906446403307;6265.8746825063245;6306.905396419057;6619.602823830585;6621.238557565894;6644.036614690891;6715.093462382565;6716.496262780311;6722.9663851680425;6726.3609957054005;6788.864222715568;6808.353206445429;6829.146356705412;6040.063790112539;6122.357152499013;6122.785702500391;6124.877502449926;6126.479249263818;6767.560108592926;6842.349976752201;6885.001674757233;6951.513394062367;6996.055532503149;6659.101021362054;6697.631630260285;6708.731650734014;6714.798556043326;6722.1261236039;6698.631575263407;6715.194176698729;6770.1537307836525;6782;6812.14848143982;6543.541952063405;6698;6710.396064354231;6770.966145169243;6804.115464989619;6664.133662623828;6721.596704197764;6807.863842723118;6827.829304267334;6829.146356705412;5375.354957405137;5381.327334083239;5391.056565101092;5397.919031214535;5405.837824865261;4621.1219868224925;4652.879617713667;4664.696794708333;4673.532646735299;4692.835750748707;5568.387477377485;5709.3434255060365;5759.049756790167;5777.508911742465;5842.532597392198;6689.364510371507;6701.028350889093;6709.161354830646;6713.765018224339;6780.660966951731;5797.449242321973;5817.621854579439;5818.912716309259;5825.1844741736195;5827.970860145672;5768.538516918637;5815.331236907809;5878.941210587925;5878.971180043561;5896.7936122235515;6519.282878883319;6524.706388212542;6584.5061620378665;6607.339266073354;6609.272979972199;6746.763863264762;6764.86470270582;6861.210960739579;6861.965690171517;6867.725290988505;6299.307076221704;6427.132337134427;6440.420362167428;6444.355564443518;6447.097406363019;6558.114654521579;6576.736930522726;6595.934040659724;6601.471882249312;6650.20197576294;6773.661316934035;6808.829779255559;6846.144231971004;6866.210385805496;6868.587884726932;6534.215894092739;6536.8365790855605;6609.801705948829;6627.602343859384;6630.403263706289;6390.4248617624635;6474.805755827333;6528.477721782341;6545.836354091186;6625;6344.936550634435;6408.775692850728;6490.707918143789;6494.09082728409;6502;6541.6075035498025;6597.208334999831;6624;6628.5691430056895;6632.2372927114;6287.937120628735;6291.559590828598;6373.044043393528;6382.425581697669;6397.264314603694 03:14:55 INFO - PID 14212 | |1;ext.html;852.399058663642;874.4534665833854;882.8940527136745;894.396282509306;894.7628878347235;41232.79383603082;42453.15093698132;42585.36121958165;42617.573824261744;42689.14621707568;38909.41635875457;39189.99999999993;39328.01679957996;39368.60631393685;39419.60580394195;7072.68172932218;7182.425405967536;7204.891926621079;7206.027186329831;7210.242924492932;7121.359077683008;7198.604076775775;7209;7212.2427145149795;7221.422286217116;7429.665665045086;8025.759227223192;8047.356211503065;8058.4359094863385;8085.3127484163915;7931;7988.720394786154;8016.078151012621;8017.999999999971;8033.357331413531;7640.5797681127515;7805.1804560520895;7807.492512986694;7864.606769661551;7923.603819809045;38374.61625383738;38512.80743596264;38763.03092422712;38873.41689874654;38926.221475570615;3453.740969427303;3476.687098161178;3498.177928186874;3498.912527186815;3500.1074725944977;31360;31469.213269668213;31493.212669683213;31497.685023149705;31508.21229469259;5212.713300768456;5231.843044708665;5246.737663116829;5259.894802103937;5279.577633789288;167682;182046;182077;182343;182530;41725.37411938823;47250.5274947253;47769.28346074742;47871.28193077107;47977.52022479731;49736.502634973185;49789.751051244515;49805.50583482502;49824.50175498271;49863;15366.462173823862;15533.533993980198;15534.689306213813;15574.065556066445;15576.610584735246;12800.423980920694;12816.166949148275;12830.743385132246;12851.357432128543;12854.742905141844;13488.5279015234;13510.527131550349;13533.593992180251;13553.932230338785;13649.317534123255;5368;5424.810131645373;5454;5473.370562385297;5530;1021.5505177721778;1021.9540120694587;1027.8612387327764;1034.3690348887174;1044.3316277582353;22897.198598048988;23192.65211021836;23258.3022509325;23373;23487.739778991607;1109.7835921995134;1115.576081089197;1123.3484578944192;1126.7352172239516;1131.5926266544038;12205.267683938991;12257.325847078318;12301.446434910451;12324.938375308066;12422;217961;219721;219926;220205;221585;53544;53730.73134634302;53815.19277210845;53850.7307463468;53942.190867137026;1410.4146779086768;1442.386985531145;1467.7798330250334;1483.0879009409136;1493.4996776079918;22742.658860116782;22796.4300892479;23189.76810231876;23254.3023709289;23379.649305260096;37097.6290237105;37123.62876371202;37185.814070929475;37197.07007324838;37197.814010929775;181000;181019;182816;182846;182993;30314.242143945696;31155.37689246248;31160.376792464478;31238.843805780827;32485.67514324921;41438.378424323055;43715.78142109269;43720.78139609282;44369.778151109036;45031.324530132726;31286.061418157493;31291.374172516877;31563.368732625677;31938;32335.514967275038;31717.36565268728;32023;32165.678343216267;32206;32353.35293294074;35737.82131089432;35839.46240806442;35983.64016359908;36095.639043609226;36143.27713445769;31025.88571514146;31610.209744756565;31625;31913;32043.198920027186;22604.66093008639;23032.493497806165;23235.53528929378;23291.53416931686;23559.175428859908 03:14:55 INFO - PID 14212 | |2;jquery.html;559.9020171469991;568.4145330309782;569.8917205730911;576.7952376906198;596.2100217212195;22278;22764.658530122062;22931.885340573273;22938.770612293894;22998.195063172752;23150.768492315114;24426.389340266458;24431.511369772594;24692.259232223063;24728.62907056391;6272.8118156455375;6438.227412710457;6447.709853056624;6451;6458.838529036765;6278.623282603058;6306.527010474209;6386.712597933104;6390.041493775924;6390.776322828702;6551.737930482775;6568.211814582257;6569.540132190748;6572.80281591553;6578.80263592093;6547.9017814732815;6552.3775241352;6559.508036897228;6563.048357988113;6567.047778072177;6071.939280607226;6681.498887583402;6981;7025.402840758542;7050.647467626598;29566.40867182666;30048.849755751082;30204;30220.24449388783;30303.696963030307;2036.5519585691125;2056.4036429435446;2058.207590077831;2059.258666879922;2066.070268379235;19787.604247914962;20321.288754893507;20761.377158685264;20819.16723331065;21074.789252107435;2469.4567195217023;2530.114459939025;2532.341591186286;2543.8092143089343;2604.6353510508543;124272.37863810714;129550.3522482391;129858.3507082468;136426.999999999;139256;20396.184152634025;20735.8963205183;21648;21887.78112218889;22304;41262.1747565053;41376;41407.58592414098;41458.79270603628;41478;10764.623238186627;10900.672979810619;10940.507677154546;10975.670729878117;11107.500162492708;8917.955410222907;8996.685116020908;9004.424225760466;9009.23421509166;9144;11054.944725276322;11207.71980700489;11214.10287177024;11275.884302229792;11318;3764.2169619532197;4081.510218773766;4132.876013719593;4168.520620128724;4482.7758612069265;953.4755884263766;955.4888134847823;976.8974257702981;987.5802783816849;1014.264658122855;18843.81156188448;19195.904020480088;19370.4188874334;19441.708374374397;19631.607367852564;1035.0203467666809;1039.3192458939407;1039.7556574205055;1046.2989796835986;1053.752368193474;10612.31019983714;10682.839757403644;10721.624743133953;10842.40366779819;10938.289011214245;444571;449570;455676;458732;469823;107630.46184769025;108571.45714271379;108663;109819;110703;1040.599369242847;1151.7063148897146;1152.4007516091585;1200.8558972923306;1218.3542722357165;19686.40940771779;20185.6972145415;20215.4946126348;20328.390148295573;20549.79450205479;52569.21146182887;53138.46861531335;53259.93480130298;53816.19275710946;55142.17286740622;64213.67893160504;65015.349846502824;65326.673366632866;65753;65772;19174.233030678617;19486.610267794847;19531.21875124979;19565.8043419564;19635;21961.78038219661;22050.917337656618;22117.225897093525;22193.334199974026;22650.546989060455;17636.29454821844;17852.10739462996;17908.194131264387;17954.371596994042;18018.72971905396;15660.765088523453;16222.18889055566;16348.509544713677;16426.260818262966;16706.248218830424;17634.382796602058;17834.01912894803;17979.101044947438;18162.45512634623;18531.44405667778;19296.71054934149;19429.902850485658;19508.414747557596;19521.902390487958;19792.703109453658;17183.226754796313;17461.12694365302;17552.82447175512;17568.472945811645;17661.205245763715 03:14:55 INFO - PID 14212 | |3;mootools.html;1344.9690966640374;1389.840168380636;1407.6903081322105;1415.5470249520151;1420.4247279851656;14532.854671453295;15100.093994360346;15252.542423727278;15266;15279.312430940607;14931.925340373311;14947.476838310662;15001.62495937602;15035;15110;2693.3132051326884;2720.9319767005836;2760.4755096531694;2765.5713364428548;2774.4451109778124;2739;2746.2036009557205;2758.6413766210367;2761.2682639100653;2765.225736793701;2639.432522007768;2754.2425832895915;2762.1023167470553;2770.6813716422666;2773.362126710858;2500.6874140732407;2511.836730612504;2521.520911026899;2524.990003998397;2532.645429639852;2515.9874200629065;2543.465872166847;2552.4767422678306;2553.8212325137247;2569.486102779452;14675.853241467663;14920.552383428514;14921.403143874231;14933.253337333199;15036.774448383283;7888.934993775824;8179.182081791773;8205.974253218348;8223.342132629436;8247.917520824774;5101.846944591668;5232.555232805178;5263.394709608406;5376.569874410077;5382.407935127133;1967.390109066194;1974.5853370792152;1979.7624285085883;2032.756069271682;2043.2542122125317;26125.216243512725;26441.074562390226;26472.73527264722;26500.86749566259;26518;6512.772052978123;6724.529282950244;6802.591844489347;6925.272846351161;6939.930600693929;16630.75053874193;17124.657506850042;17193.484195474157;17244.568885777957;17282.913585431994;7778.105517865405;7979.241972012649;7980;7980.800479987931;7994.880076798852;7310.378617817439;7382.704691812375;7449.515781474187;7471.514351567131;7481.663325150382;5091.210862316347;5179.948200518022;5189.221616757516;5206.140986737146;5363.973180134074;1497.408523633159;1499.242882344409;1510.8564686354778;1520.065159926637;1527.4806565767692;887.6449420231829;906.1889608800087;916.3860213656866;919.6873063158558;927.7448701607112;7709.8458030839065;7817.804554886174;7826.7651970440975;7829.569373684502;7867;715.7888422915253;717.6519388096768;735.5292612727858;745.262190431469;747.8466914282559;4661.279058166272;5265.605079619044;5454.754536045887;5497.587680923867;5559.33288005442;20104.195832166843;20425.48936276575;20549.178032878815;21315.573688526452;21320.466988325104;20539.075741591365;20548;20586;20728;21361.465963351042;11263.549458021751;11355.886441135483;11482.712932176595;11501.53993840237;11537.423128843524;8341.916580834113;8496.830063398822;8582.399232053696;8600.827983440422;8632.438891472035;18303.72544411808;18645.881247125217;18727.531811704815;18850.905745471184;19105.23579056878;18523.062804245277;19546.31587894417;19614.313499027467;20071.39785806428;20193.091310891337;9778.85331720039;10134.189264858645;10138.645147419806;10502.894971050497;11031.22781405326;13416.39626216842;13629.79555306691;13640.181589104288;13659.385327660479;13677.110987785762;11231.775364492501;11259.718507037389;11483.196176267915;11485.655430337103;11712.531498739954;11038.734673957648;11170.832437513607;11214.495347709535;11304.208705390543;11506.654800356002;9859.852102218329;9976.301658884098;9982.900170998488;9984.500774961078;9985.60057597688;7547.660355284135;7563.52511260299;7583.431242656712;7678.69285228607;7690.769276921701;7502.437317201123;7559.8110047247055;7590.696372145052;7687.5387476751575;7742.535447873146 03:14:55 INFO - PID 14212 | |4;prototype.html;501.97342550743497;518.6991544903956;523.4320761973258;525.6163001009264;532.9014132385507;6241;6280.089387038876;6378.521610879186;6388.744450221986;6420.587470756438;6244.250689917205;6271.341509141543;6291.748330066792;6318.620882747038;6327.430531252198;5191.818286359978;5231.136862417697;5237.031149237403;5241.711705856176;5275.28783614211;4927.507249275061;5179.938112686909;5223.477652234784;5232.73836308183;5287.682739035651;4913.680610760307;4969.925451118218;4970.950290497103;5004.424491183524;5030.170021946375;4936.481669424695;4974.27872958419;5001.874578219908;5010.599152067826;5021.297018417425;4473.217186992263;4491;4504.8198072077075;4528.909421811578;4529;6198.442140207403;6230.314665386803;6234.688265586748;6237.688115594247;6241.282252540925;5750.137479378127;5814.854628634275;5821.330546987108;5832.883342333172;5837.299524057098;6559.93440065598;6561.507886908454;6574.769883054118;6603.834904127387;6622.476830329003;4865.829695960624;4873.658843880929;4878.390201224847;4888.266759985995;4905.705657660552;6615.305392933769;6817.761378351784;6863.558652682893;6871.931280687229;6919.266889578588;5037.748112594356;5048.444671086178;5058.570021548209;5062.139436295838;5096.184610462383;5091.745412729349;5095.974520127375;5119.206522988943;5136.9743151284;5141.640085194001;5670.319561652545;5686.744096515667;5769.249997500298;5772.7690892363835;5779.653220806765;6677.799666010027;6685.632290223987;6696.19645642526;6714.496412769062;6731.528792984444;1762.4624489530815;1776.360510216321;1776.9733453998201;1777.6977913754693;1789.1929151557022;1168.8597368315686;1203.7050922524038;1210.9091818113677;1212.8847759462838;1242.3043095866162;5591.496765291144;5669.461401166883;5739.512141467939;5776.104703770922;5803.5357171426185;6656.600603963778;6766.69549870257;6794.728210871609;6887.242403335629;6887.7244910203035;5535.640183388067;5590.161475778666;5744.167095771089;5784.1902133701315;5796.971015144982;3546.202104526461;3558.1638314995957;3574.249407624428;3574.8033858137533;3635.9818200908826;6333.303336632966;6464.062710906892;6500.317466666026;6535.509836762167;6550.312217217219;6959.304069593;6959.61722105289;6961.79114626562;7003.299670032956;7014.92985070153;6198.776236561708;6460.483161347175;6492.675366231764;6499.7400103995315;6531.379518945692;6476.449501792212;6624.87377145896;6668.633225172662;6689.26418094019;6698.296678848651;6485.578437401554;6625;6642.4686025118845;6668.299828517936;6685.298043705341;6319.6208227506495;6346.540295731915;6451.3548645135115;6466.708998095191;6526.967365163144;4892.2661600760175;5064.139096353702;5067.77195026232;5071.18860982241;5090.41460232078;6581.769638062645;6640.535162538576;6708.42978346846;6895.552368722247;6938.710225625632;6515.087887695821;6543.051257567721;6629.370209830058;6631.734730610721;6634.668266586747;6578.342165783383;6602.273749887605;6617;6681.599104053772;6683.4319082876555;6491.935080649133;6506.577072490273;6552.901706474502;6565.507586930904;6574.389274627747;6638.402543771083;6680.632565208765;6710.66446677674;6732.562383445061;6756.864862702817;6489.4808415325715;6502.642354670538;6508.316626754312;6509.674516274262;6512.678533947626 03:14:55 INFO - PID 14212 | |5;yui.html;879.4723166100339;912.3750231091707;916.9954150229252;928.8792456980591;941.6421759731303;19543.70684439733;20619.27832525862;20677.17291308348;20697.896510517447;20701;18272.543186420346;18869.716954245698;18885.52786180346;18998.525036874085;19142.71285930712;947.3415975896754;966.0773960867355;969.9466529340883;971.5433746139339;972.3776782858976;956.7321150077989;971.7084874537646;975.7267964969819;977.7946631207456;996.5615129343103;1059.35379418555;1060.9575616975312;1061.686802393296;1061.8566493523392;1062.5324857062867;996.8006398720285;1027.4708525109575;1049.853020577116;1055.145332280855;1055.7360659835042;755.2070326157512;756.2324240895496;756.7464899258755;756.8713318735828;757.1557713149854;20432.387028389174;20503.2823851166;20604.793952060438;20644.896775516027;20670.689939650918;21124.894375528023;22579.887100564556;22715.20496782605;22756.317310480714;22774.886125569265;17262.3958161465;17587.824121758746;17671.293148274053;17810.55473613157;17820.287188512444;3635.4183330666965;3641.908952276188;3651.6165802590876;3666.5966743658178;3671.834767435472;141637;142749;143310.99999999895;144044;145966;16741.6651666966;16991.575210619587;17036.829631703524;17099;17298.65402691939;30929.845350773103;31367;31491.37017259642;31638.841805790824;31799.364012719616;7987.720429784929;8149.877751833727;8204.425690201628;8218.342532597379;8271.875921861056;4217.7891105444605;4275.743455392686;4295.52749197588;4303.440552728125;4314.89212769677;5306.52241298285;5404.432534583891;5417.83746487606;5431.619786614978;5437.048516509674;957.3203025851724;990.3216296836546;993.3592832622918;1003.5484032185545;1009.1573536097294;697.8255436140964;705.7381093595015;715.1489727224587;725.1588157737;733.1422235983912;10941.507632156572;11593;11632.418379081013;11681.357525336189;12070.577529786415;679.1951537428164;690.7237105157876;691.7924622613195;705.1256442011868;706.9187043489961;5560.4906726287345;5650.378458369576;5688.943110568925;5701.059325211294;5752.252207213036;124524;126945.36527317304;127595;129374.35312823564;132761.33619331842;110535;111100;113275;113797;114441.4277928605;96869;99380.50309748405;99887;100186;102078.48960755297;10238.488075596042;10353.327033742782;10476.371417714961;10650;10821.513031913426;44113.77943110264;44395.33406998833;44617;45099.32351014803;45615;55989;57156.42843571511;59270;59572.70213648904;59841.700791495765;15506.9224653876;15788.184358798886;15897.602559936095;16030.27863746111;16039.599010024842;17628.911855441154;17775.111244437983;17791.644167116843;17940.461786146436;18160.636787264444;15876;16083.356665733707;16232.431864884673;16256.593585160466;16421.507354779376;15193.164375959428;15429.305681244146;15491.30289136969;15509.612259693598;15609.921950390175;14367.928160359132;14713.632159196106;14764.557063288119;14833.554993350217;14838;11052.834207486734;11135.832962505407;11167.72080697989;11309.095272378354;11388.772224555629;11105.722356941142;11112.38881861473;11160.665180044612;11249.943750281196;11382.317060976367 03:14:55 INFO - PID 14212 | __end_tp_report 03:14:55 INFO - PID 14212 | __start_cc_report 03:14:55 INFO - PID 14212 | _x_x_mozilla_cycle_collect,285 03:14:55 INFO - PID 14212 | __end_cc_report 03:14:55 INFO - PID 14212 | __startTimestamp1505816095271__endTimestamp 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | ------- Summary: start ------- 03:14:55 INFO - PID 14212 | Number of tests: 6 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#0] dojo.html Cycles:165 Average:6145.16 Median:6408.78 stddev:879.19 (13.7%) stddev-sans-first:849.11 03:14:55 INFO - PID 14212 | Values: 3113.3 3134.2 3138.1 3138.6 3144.8 6097.1 6259.4 6263.7 6296.8 6393.0 6167.6 6184.3 6217.7 6243.4 6261.8 5708.2 5709.7 5750.9 5760.5 5842.7 5840.4 5841.6 5854.8 5862.1 5891.5 99.7 5739.1 5814.0 5820.1 5824.4 5613.5 5644.0 5644.8 5691.7 5783.0 5666.2 5683.1 5747.5 5748.3 5759.3 6208.0 6224.4 6236.9 6265.9 6306.9 6619.6 6621.2 6644.0 6715.1 6716.5 6723.0 6726.4 6788.9 6808.4 6829.1 6040.1 6122.4 6122.8 6124.9 6126.5 6767.6 6842.3 6885.0 6951.5 6996.1 6659.1 6697.6 6708.7 6714.8 6722.1 6698.6 6715.2 6770.2 6782.0 6812.1 6543.5 6698.0 6710.4 6771.0 6804.1 6664.1 6721.6 6807.9 6827.8 6829.1 5375.4 5381.3 5391.1 5397.9 5405.8 4621.1 4652.9 4664.7 4673.5 4692.8 5568.4 5709.3 5759.0 5777.5 5842.5 6689.4 6701.0 6709.2 6713.8 6780.7 5797.4 5817.6 5818.9 5825.2 5828.0 5768.5 5815.3 5878.9 5879.0 5896.8 6519.3 6524.7 6584.5 6607.3 6609.3 6746.8 6764.9 6861.2 6862.0 6867.7 6299.3 6427.1 6440.4 6444.4 6447.1 6558.1 6576.7 6595.9 6601.5 6650.2 6773.7 6808.8 6846.1 6866.2 6868.6 6534.2 6536.8 6609.8 6627.6 6630.4 6390.4 6474.8 6528.5 6545.8 6625.0 6344.9 6408.8 6490.7 6494.1 6502.0 6541.6 6597.2 6624.0 6628.6 6632.2 6287.9 6291.6 6373.0 6382.4 6397.3 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#1] ext.html Cycles:180 Average:36307.25 Median:3465.21 stddev:50398.25 (1454.4%) stddev-sans-first:50469.31 03:14:55 INFO - PID 14212 | Values: 852.4 874.5 882.9 894.4 894.8 41232.8 42453.2 42585.4 42617.6 42689.1 38909.4 39190.0 39328.0 39368.6 39419.6 7072.7 7182.4 7204.9 7206.0 7210.2 7121.4 7198.6 7209.0 7212.2 7221.4 7429.7 8025.8 8047.4 8058.4 8085.3 7931.0 7988.7 8016.1 8018.0 8033.4 7640.6 7805.2 7807.5 7864.6 7923.6 38374.6 38512.8 38763.0 38873.4 38926.2 3453.7 3476.7 3498.2 3498.9 3500.1 31360.0 31469.2 31493.2 31497.7 31508.2 5212.7 5231.8 5246.7 5259.9 5279.6 167682.0 182046.0 182077.0 182343.0 182530.0 41725.4 47250.5 47769.3 47871.3 47977.5 49736.5 49789.8 49805.5 49824.5 49863.0 15366.5 15533.5 15534.7 15574.1 15576.6 12800.4 12816.2 12830.7 12851.4 12854.7 13488.5 13510.5 13533.6 13553.9 13649.3 5368.0 5424.8 5454.0 5473.4 5530.0 1021.6 1022.0 1027.9 1034.4 1044.3 22897.2 23192.7 23258.3 23373.0 23487.7 1109.8 1115.6 1123.3 1126.7 1131.6 12205.3 12257.3 12301.4 12324.9 12422.0 217961.0 219721.0 219926.0 220205.0 221585.0 53544.0 53730.7 53815.2 53850.7 53942.2 1410.4 1442.4 1467.8 1483.1 1493.5 22742.7 22796.4 23189.8 23254.3 23379.6 37097.6 37123.6 37185.8 37197.1 37197.8 181000.0 181019.0 182816.0 182846.0 182993.0 30314.2 31155.4 31160.4 31238.8 32485.7 41438.4 43715.8 43720.8 44369.8 45031.3 31286.1 31291.4 31563.4 31938.0 32335.5 31717.4 32023.0 32165.7 32206.0 32353.4 35737.8 35839.5 35983.6 36095.6 36143.3 31025.9 31610.2 31625.0 31913.0 32043.2 22604.7 23032.5 23235.5 23291.5 23559.2 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#2] jquery.html Cycles:180 Average:34257.87 Median:22006.35 stddev:76671.47 (348.4%) stddev-sans-first:76844.80 03:14:55 INFO - PID 14212 | Values: 559.9 568.4 569.9 576.8 596.2 22278.0 22764.7 22931.9 22938.8 22998.2 23150.8 24426.4 24431.5 24692.3 24728.6 6272.8 6438.2 6447.7 6451.0 6458.8 6278.6 6306.5 6386.7 6390.0 6390.8 6551.7 6568.2 6569.5 6572.8 6578.8 6547.9 6552.4 6559.5 6563.0 6567.0 6071.9 6681.5 6981.0 7025.4 7050.6 29566.4 30048.8 30204.0 30220.2 30303.7 2036.6 2056.4 2058.2 2059.3 2066.1 19787.6 20321.3 20761.4 20819.2 21074.8 2469.5 2530.1 2532.3 2543.8 2604.6 124272.4 129550.4 129858.4 136427.0 139256.0 20396.2 20735.9 21648.0 21887.8 22304.0 41262.2 41376.0 41407.6 41458.8 41478.0 10764.6 10900.7 10940.5 10975.7 11107.5 8918.0 8996.7 9004.4 9009.2 9144.0 11054.9 11207.7 11214.1 11275.9 11318.0 3764.2 4081.5 4132.9 4168.5 4482.8 953.5 955.5 976.9 987.6 1014.3 18843.8 19195.9 19370.4 19441.7 19631.6 1035.0 1039.3 1039.8 1046.3 1053.8 10612.3 10682.8 10721.6 10842.4 10938.3 444571.0 449570.0 455676.0 458732.0 469823.0 107630.5 108571.5 108663.0 109819.0 110703.0 1040.6 1151.7 1152.4 1200.9 1218.4 19686.4 20185.7 20215.5 20328.4 20549.8 52569.2 53138.5 53259.9 53816.2 55142.2 64213.7 65015.3 65326.7 65753.0 65772.0 19174.2 19486.6 19531.2 19565.8 19635.0 21961.8 22050.9 22117.2 22193.3 22650.5 17636.3 17852.1 17908.2 17954.4 18018.7 15660.8 16222.2 16348.5 16426.3 16706.2 17634.4 17834.0 17979.1 18162.5 18531.4 19296.7 19429.9 19508.4 19521.9 19792.7 17183.2 17461.1 17552.8 17568.5 17661.2 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#3] mootools.html Cycles:180 Average:9271.58 Median:14540.25 stddev:6587.05 (45.3%) stddev-sans-first:6578.60 03:14:55 INFO - PID 14212 | Values: 1345.0 1389.8 1407.7 1415.5 1420.4 14532.9 15100.1 15252.5 15266.0 15279.3 14931.9 14947.5 15001.6 15035.0 15110.0 2693.3 2720.9 2760.5 2765.6 2774.4 2739.0 2746.2 2758.6 2761.3 2765.2 2639.4 2754.2 2762.1 2770.7 2773.4 2500.7 2511.8 2521.5 2525.0 2532.6 2516.0 2543.5 2552.5 2553.8 2569.5 14675.9 14920.6 14921.4 14933.3 15036.8 7888.9 8179.2 8206.0 8223.3 8247.9 5101.8 5232.6 5263.4 5376.6 5382.4 1967.4 1974.6 1979.8 2032.8 2043.3 26125.2 26441.1 26472.7 26500.9 26518.0 6512.8 6724.5 6802.6 6925.3 6939.9 16630.8 17124.7 17193.5 17244.6 17282.9 7778.1 7979.2 7980.0 7980.8 7994.9 7310.4 7382.7 7449.5 7471.5 7481.7 5091.2 5179.9 5189.2 5206.1 5364.0 1497.4 1499.2 1510.9 1520.1 1527.5 887.6 906.2 916.4 919.7 927.7 7709.8 7817.8 7826.8 7829.6 7867.0 715.8 717.7 735.5 745.3 747.8 4661.3 5265.6 5454.8 5497.6 5559.3 20104.2 20425.5 20549.2 21315.6 21320.5 20539.1 20548.0 20586.0 20728.0 21361.5 11263.5 11355.9 11482.7 11501.5 11537.4 8341.9 8496.8 8582.4 8600.8 8632.4 18303.7 18645.9 18727.5 18850.9 19105.2 18523.1 19546.3 19614.3 20071.4 20193.1 9778.9 10134.2 10138.6 10502.9 11031.2 13416.4 13629.8 13640.2 13659.4 13677.1 11231.8 11259.7 11483.2 11485.7 11712.5 11038.7 11170.8 11214.5 11304.2 11506.7 9859.9 9976.3 9982.9 9984.5 9985.6 7547.7 7563.5 7583.4 7678.7 7690.8 7502.4 7559.8 7590.7 7687.5 7742.5 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#4] prototype.html Cycles:180 Average:5557.36 Median:6241.14 stddev:1555.00 (24.9%) stddev-sans-first:1512.35 03:14:55 INFO - PID 14212 | Values: 502.0 518.7 523.4 525.6 532.9 6241.0 6280.1 6378.5 6388.7 6420.6 6244.3 6271.3 6291.7 6318.6 6327.4 5191.8 5231.1 5237.0 5241.7 5275.3 4927.5 5179.9 5223.5 5232.7 5287.7 4913.7 4969.9 4971.0 5004.4 5030.2 4936.5 4974.3 5001.9 5010.6 5021.3 4473.2 4491.0 4504.8 4528.9 4529.0 6198.4 6230.3 6234.7 6237.7 6241.3 5750.1 5814.9 5821.3 5832.9 5837.3 6559.9 6561.5 6574.8 6603.8 6622.5 4865.8 4873.7 4878.4 4888.3 4905.7 6615.3 6817.8 6863.6 6871.9 6919.3 5037.7 5048.4 5058.6 5062.1 5096.2 5091.7 5096.0 5119.2 5137.0 5141.6 5670.3 5686.7 5769.2 5772.8 5779.7 6677.8 6685.6 6696.2 6714.5 6731.5 1762.5 1776.4 1777.0 1777.7 1789.2 1168.9 1203.7 1210.9 1212.9 1242.3 5591.5 5669.5 5739.5 5776.1 5803.5 6656.6 6766.7 6794.7 6887.2 6887.7 5535.6 5590.2 5744.2 5784.2 5797.0 3546.2 3558.2 3574.2 3574.8 3636.0 6333.3 6464.1 6500.3 6535.5 6550.3 6959.3 6959.6 6961.8 7003.3 7014.9 6198.8 6460.5 6492.7 6499.7 6531.4 6476.4 6624.9 6668.6 6689.3 6698.3 6485.6 6625.0 6642.5 6668.3 6685.3 6319.6 6346.5 6451.4 6466.7 6527.0 4892.3 5064.1 5067.8 5071.2 5090.4 6581.8 6640.5 6708.4 6895.6 6938.7 6515.1 6543.1 6629.4 6631.7 6634.7 6578.3 6602.3 6617.0 6681.6 6683.4 6491.9 6506.6 6552.9 6565.5 6574.4 6638.4 6680.6 6710.7 6732.6 6756.9 6489.5 6502.6 6508.3 6509.7 6512.7 03:14:55 INFO - PID 14212 | 03:14:55 INFO - PID 14212 | [#5] yui.html Cycles:180 Average:24872.30 Median:20554.04 stddev:36642.07 (178.3%) stddev-sans-first:36700.58 03:14:55 INFO - PID 14212 | Values: 879.5 912.4 917.0 928.9 941.6 19543.7 20619.3 20677.2 20697.9 20701.0 18272.5 18869.7 18885.5 18998.5 19142.7 947.3 966.1 969.9 971.5 972.4 956.7 971.7 975.7 977.8 996.6 1059.4 1061.0 1061.7 1061.9 1062.5 996.8 1027.5 1049.9 1055.1 1055.7 755.2 756.2 756.7 756.9 757.2 20432.4 20503.3 20604.8 20644.9 20670.7 21124.9 22579.9 22715.2 22756.3 22774.9 17262.4 17587.8 17671.3 17810.6 17820.3 3635.4 3641.9 3651.6 3666.6 3671.8 141637.0 142749.0 143311.0 144044.0 145966.0 16741.7 16991.6 17036.8 17099.0 17298.7 30929.8 31367.0 31491.4 31638.8 31799.4 7987.7 8149.9 8204.4 8218.3 8271.9 4217.8 4275.7 4295.5 4303.4 4314.9 5306.5 5404.4 5417.8 5431.6 5437.0 957.3 990.3 993.4 1003.5 1009.2 697.8 705.7 715.1 725.2 733.1 10941.5 11593.0 11632.4 11681.4 12070.6 679.2 690.7 691.8 705.1 706.9 5560.5 5650.4 5688.9 5701.1 5752.3 124524.0 126945.4 127595.0 129374.4 132761.3 110535.0 111100.0 113275.0 113797.0 114441.4 96869.0 99380.5 99887.0 100186.0 102078.5 10238.5 10353.3 10476.4 10650.0 10821.5 44113.8 44395.3 44617.0 45099.3 45615.0 55989.0 57156.4 59270.0 59572.7 59841.7 15506.9 15788.2 15897.6 16030.3 16039.6 17628.9 17775.1 17791.6 17940.5 18160.6 15876.0 16083.4 16232.4 16256.6 16421.5 15193.2 15429.3 15491.3 15509.6 15609.9 14367.9 14713.6 14764.6 14833.6 14838.0 11052.8 11135.8 11167.7 11309.1 11388.8 11105.7 11112.4 11160.7 11249.9 11382.3 03:14:55 INFO - PID 14212 | -------- Summary: end -------- 03:14:55 INFO - PID 14212 | 03:14:55 INFO - TEST-INFO | 14212: exit 0 03:14:55 INFO - TEST-OK | dromaeo_css | took 1107544ms 03:14:55 INFO - TEST-START | kraken 03:14:55 INFO - Initialising browser for kraken test... 03:14:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37542/getInfo.html -profile /tmp/tmpBO_lO4/profile 03:14:55 INFO - TEST-INFO | started process 14585 (/builds/slave/test/build/application/firefox/firefox http://localhost:37542/getInfo.html) 03:15:00 INFO - TEST-INFO | 14585: exit 0 03:15:00 INFO - Browser initialized. 03:15:00 INFO - Running cycle 1/1 for kraken test... 03:15:00 INFO - Using env: {'DISPLAY': ':0', 03:15:00 INFO - 'HOME': '/home/cltbld', 03:15:00 INFO - 'JSGC_DISABLE_POISONING': '1', 03:15:00 INFO - 'LANG': 'en_US.UTF-8', 03:15:00 INFO - 'LANGUAGE': 'en_US:en', 03:15:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:15:00 INFO - 'LOGNAME': 'cltbld', 03:15:00 INFO - 'MAIL': '/var/mail/cltbld', 03:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:00 INFO - 'MOZ_CRASHREPORTER': '1', 03:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:15:00 INFO - 'MOZ_NO_REMOTE': '1', 03:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:00 INFO - 'NO_EM_RESTART': '1', 03:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:00 INFO - 'PWD': '/builds/slave/test', 03:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:00 INFO - 'RUST_BACKTRACE': 'full', 03:15:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:00 INFO - 'SHELL': '/bin/bash', 03:15:00 INFO - 'SHLVL': '1', 03:15:00 INFO - 'TERM': 'linux', 03:15:00 INFO - 'TMOUT': '86400', 03:15:00 INFO - 'USER': 'cltbld', 03:15:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384', 03:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:00 INFO - '_': '/tools/buildbot/bin/python'} 03:15:00 INFO - TEST-INFO | started process 14816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBO_lO4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:01 INFO - PID 14816 | 03:15:01 INFO - PID 14816 | (/builds/slave/test/build/application/firefox/firefox:14865): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:15:01 INFO - PID 14816 | 03:15:11 INFO - PID 14816 | RSS: Main: 156311552 03:15:11 INFO - PID 14816 | 03:15:14 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37542/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:15 INFO - PID 14816 | RSS: Main: 162910208 03:15:15 INFO - PID 14816 | 03:15:17 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37542/tests/kraken/driver.html?testName=audio-dft) 03:15:18 INFO - PID 14816 | RSS: Main: 162709504 03:15:18 INFO - PID 14816 | 03:15:21 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37542/tests/kraken/driver.html?testName=audio-fft) 03:15:21 INFO - PID 14816 | RSS: Main: 158846976 03:15:21 INFO - PID 14816 | 03:15:23 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37542/tests/kraken/driver.html?testName=audio-oscillator) 03:15:24 INFO - PID 14816 | RSS: Main: 159608832 03:15:24 INFO - PID 14816 | 03:15:26 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:27 INFO - PID 14816 | RSS: Main: 159485952 03:15:27 INFO - PID 14816 | 03:15:30 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37542/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:31 INFO - PID 14816 | RSS: Main: 162689024 03:15:31 INFO - PID 14816 | 03:15:34 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37542/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:35 INFO - PID 14816 | RSS: Main: 162103296 03:15:35 INFO - PID 14816 | 03:15:38 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37542/tests/kraken/driver.html?testName=json-parse-financial) 03:15:38 INFO - PID 14816 | RSS: Main: 161890304 03:15:38 INFO - PID 14816 | 03:15:40 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:41 INFO - PID 14816 | RSS: Main: 161767424 03:15:41 INFO - PID 14816 | 03:15:42 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:43 INFO - PID 14816 | RSS: Main: 161955840 03:15:43 INFO - PID 14816 | 03:15:45 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:46 INFO - PID 14816 | RSS: Main: 158814208 03:15:46 INFO - PID 14816 | 03:15:48 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:49 INFO - PID 14816 | RSS: Main: 159121408 03:15:49 INFO - PID 14816 | 03:15:52 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:52 INFO - PID 14816 | RSS: Main: 159633408 03:15:52 INFO - PID 14816 | 03:15:54 INFO - PID 14816 | Cycle 1(1): loaded http://localhost:37542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37542/tests/kraken/driver.html?testName=ai-astar) 03:15:55 INFO - PID 14816 | RSS: Main: 160423936 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | __start_tp_report 03:15:55 INFO - PID 14816 | _x_x_mozilla_page_load 03:15:55 INFO - PID 14816 | _x_x_mozilla_page_load_details 03:15:55 INFO - PID 14816 | |i|pagename|runs| 03:15:55 INFO - PID 14816 | |0;ai-astar;108;109;107;106;107;109;107;107;108;106 03:15:55 INFO - PID 14816 | |1;audio-beat-detection;118;116;117;117;117;115;116;117;140;117 03:15:55 INFO - PID 14816 | |2;audio-dft;162;162;166;162;162;161;161;167;165;165 03:15:55 INFO - PID 14816 | |3;audio-fft;75;73;73;75;75;73;74;77;73;73 03:15:55 INFO - PID 14816 | |4;audio-oscillator;79;81;78;78;78;77;79;79;80;79 03:15:55 INFO - PID 14816 | |5;imaging-gaussian-blur;114;114;110;115;114;112;114;118;114;114 03:15:55 INFO - PID 14816 | |6;imaging-darkroom;149;148;150;147;151;148;149;149;149;150 03:15:55 INFO - PID 14816 | |7;imaging-desaturate;94;94;94;95;94;94;95;94;96;94 03:15:55 INFO - PID 14816 | |8;json-parse-financial;56;54;53;53;52;53;55;55;53;53 03:15:55 INFO - PID 14816 | |9;json-stringify-tinderbox;38;38;38;38;37;38;37;38;37;42 03:15:55 INFO - PID 14816 | |10;stanford-crypto-aes;75;77;73;76;81;73;78;75;76;76 03:15:55 INFO - PID 14816 | |11;stanford-crypto-ccm;115;114;116;115;115;115;116;117;110;117 03:15:55 INFO - PID 14816 | |12;stanford-crypto-pbkdf2;177;171;178;188;168;174;169;171;168;174 03:15:55 INFO - PID 14816 | |13;stanford-crypto-sha256-iterative;66;68;66;65;66;64;63;69;70;68 03:15:55 INFO - PID 14816 | __end_tp_report 03:15:55 INFO - PID 14816 | __start_cc_report 03:15:55 INFO - PID 14816 | _x_x_mozilla_cycle_collect,713 03:15:55 INFO - PID 14816 | __end_cc_report 03:15:55 INFO - PID 14816 | __startTimestamp1505816155024__endTimestamp 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | ------- Summary: start ------- 03:15:55 INFO - PID 14816 | Number of tests: 14 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#0] ai-astar Cycles:10 Average:107.40 Median:107.50 stddev:1.07 (1.0%) stddev-sans-first:1.12 03:15:55 INFO - PID 14816 | Values: 108.0 109.0 107.0 106.0 107.0 109.0 107.0 107.0 108.0 106.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:117.00 stddev:7.42 (6.3%) stddev-sans-first:7.87 03:15:55 INFO - PID 14816 | Values: 118.0 116.0 117.0 117.0 117.0 115.0 116.0 117.0 140.0 117.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.21 (1.4%) stddev-sans-first:2.30 03:15:55 INFO - PID 14816 | Values: 162.0 162.0 166.0 162.0 162.0 161.0 161.0 167.0 165.0 165.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.37 (1.8%) stddev-sans-first:1.41 03:15:55 INFO - PID 14816 | Values: 75.0 73.0 73.0 75.0 75.0 73.0 74.0 77.0 73.0 73.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:1.14 (1.4%) stddev-sans-first:1.20 03:15:55 INFO - PID 14816 | Values: 79.0 81.0 78.0 78.0 78.0 77.0 79.0 79.0 80.0 79.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:2.02 (1.8%) stddev-sans-first:2.15 03:15:55 INFO - PID 14816 | Values: 114.0 114.0 110.0 115.0 114.0 112.0 114.0 118.0 114.0 114.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 03:15:55 INFO - PID 14816 | Values: 149.0 148.0 150.0 147.0 151.0 148.0 149.0 149.0 149.0 150.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:15:55 INFO - PID 14816 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 96.0 94.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.25 (2.3%) stddev-sans-first:1.01 03:15:55 INFO - PID 14816 | Values: 56.0 54.0 53.0 53.0 52.0 53.0 55.0 55.0 53.0 53.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:1.45 (3.8%) stddev-sans-first:1.54 03:15:55 INFO - PID 14816 | Values: 38.0 38.0 38.0 38.0 37.0 38.0 37.0 38.0 37.0 42.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:2.36 (3.1%) stddev-sans-first:2.47 03:15:55 INFO - PID 14816 | Values: 75.0 77.0 73.0 76.0 81.0 73.0 78.0 75.0 76.0 76.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:2.00 (1.7%) stddev-sans-first:2.12 03:15:55 INFO - PID 14816 | Values: 115.0 114.0 116.0 115.0 115.0 115.0 116.0 117.0 110.0 117.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:6.11 (3.5%) stddev-sans-first:6.37 03:15:55 INFO - PID 14816 | Values: 177.0 171.0 178.0 188.0 168.0 174.0 169.0 171.0 168.0 174.0 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.22 (3.3%) stddev-sans-first:2.35 03:15:55 INFO - PID 14816 | Values: 66.0 68.0 66.0 65.0 66.0 64.0 63.0 69.0 70.0 68.0 03:15:55 INFO - PID 14816 | -------- Summary: end -------- 03:15:55 INFO - PID 14816 | 03:15:55 INFO - PID 14816 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:15:55 INFO - TEST-INFO | 14816: exit 0 03:15:55 INFO - TEST-OK | kraken | took 59820ms 03:15:55 INFO - SUITE-END | took 1167s 03:15:55 INFO - Completed test suite (00:19:27) 03:15:55 INFO - javascript benchmark 03:15:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8556.930053639499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.3150706844494, 3134.2477805326716, 3138.1370123216097, 3138.639056508502, 3144.842757862107, 6097.085437184424, 6259.405356491137, 6263.655498947556, 6296.811095667132, 6393.0410438434255, 6167.568270221086, 6184.319724830265, 6217.689115544216, 6243.406876346739, 6261.780837670683, 5708.172315014331, 5709.743061562219, 5750.942490575083, 5760.510356619692, 5842.737076831553, 5840.415958404168, 5841.64950102993, 5854.824355269348, 5862.149988251701, 5891.469767720904, 99.68034518202253, 5739.110437882135, 5814.040683287274, 5820.068788993762, 5824.388439213885, 5613.46672066153, 5644.04051311274, 5644.8024319148635, 5691.658500489983, 5783.0, 5666.206731057655, 5683.147527870811, 5747.511461525775, 5748.2527271454865, 5759.308882934033, 6208.0, 6224.377562243784, 6236.906446403307, 6265.8746825063245, 6306.905396419057, 6619.602823830585, 6621.238557565894, 6644.036614690891, 6715.093462382565, 6716.496262780311, 6722.9663851680425, 6726.3609957054005, 6788.864222715568, 6808.353206445429, 6829.146356705412, 6040.063790112539, 6122.357152499013, 6122.785702500391, 6124.877502449926, 6126.479249263818, 6767.560108592926, 6842.349976752201, 6885.001674757233, 6951.513394062367, 6996.055532503149, 6659.101021362054, 6697.631630260285, 6708.731650734014, 6714.798556043326, 6722.1261236039, 6698.631575263407, 6715.194176698729, 6770.1537307836525, 6782.0, 6812.14848143982, 6543.541952063405, 6698.0, 6710.396064354231, 6770.966145169243, 6804.115464989619, 6664.133662623828, 6721.596704197764, 6807.863842723118, 6827.829304267334, 6829.146356705412, 5375.354957405137, 5381.327334083239, 5391.056565101092, 5397.919031214535, 5405.837824865261, 4621.1219868224925, 4652.879617713667, 4664.696794708333, 4673.532646735299, 4692.835750748707, 5568.387477377485, 5709.3434255060365, 5759.049756790167, 5777.508911742465, 5842.532597392198, 6689.364510371507, 6701.028350889093, 6709.161354830646, 6713.765018224339, 6780.660966951731, 5797.449242321973, 5817.621854579439, 5818.912716309259, 5825.1844741736195, 5827.970860145672, 5768.538516918637, 5815.331236907809, 5878.941210587925, 5878.971180043561, 5896.7936122235515, 6519.282878883319, 6524.706388212542, 6584.5061620378665, 6607.339266073354, 6609.272979972199, 6746.763863264762, 6764.86470270582, 6861.210960739579, 6861.965690171517, 6867.725290988505, 6299.307076221704, 6427.132337134427, 6440.420362167428, 6444.355564443518, 6447.097406363019, 6558.114654521579, 6576.736930522726, 6595.934040659724, 6601.471882249312, 6650.20197576294, 6773.661316934035, 6808.829779255559, 6846.144231971004, 6866.210385805496, 6868.587884726932, 6534.215894092739, 6536.8365790855605, 6609.801705948829, 6627.602343859384, 6630.403263706289, 6390.4248617624635, 6474.805755827333, 6528.477721782341, 6545.836354091186, 6625.0, 6344.936550634435, 6408.775692850728, 6490.707918143789, 6494.09082728409, 6502.0, 6541.6075035498025, 6597.208334999831, 6624.0, 6628.5691430056895, 6632.2372927114, 6287.937120628735, 6291.559590828598, 6373.044043393528, 6382.425581697669, 6397.264314603694], "value": 6082.5548738920825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.399058663642, 874.4534665833854, 882.8940527136745, 894.396282509306, 894.7628878347235, 41232.79383603082, 42453.15093698132, 42585.36121958165, 42617.573824261744, 42689.14621707568, 38909.41635875457, 39189.99999999993, 39328.01679957996, 39368.60631393685, 39419.60580394195, 7072.68172932218, 7182.425405967536, 7204.891926621079, 7206.027186329831, 7210.242924492932, 7121.359077683008, 7198.604076775775, 7209.0, 7212.2427145149795, 7221.422286217116, 7429.665665045086, 8025.759227223192, 8047.356211503065, 8058.4359094863385, 8085.3127484163915, 7931.0, 7988.720394786154, 8016.078151012621, 8017.999999999971, 8033.357331413531, 7640.5797681127515, 7805.1804560520895, 7807.492512986694, 7864.606769661551, 7923.603819809045, 38374.61625383738, 38512.80743596264, 38763.03092422712, 38873.41689874654, 38926.221475570615, 3453.740969427303, 3476.687098161178, 3498.177928186874, 3498.912527186815, 3500.1074725944977, 31360.0, 31469.213269668213, 31493.212669683213, 31497.685023149705, 31508.21229469259, 5212.713300768456, 5231.843044708665, 5246.737663116829, 5259.894802103937, 5279.577633789288, 167682.0, 182046.0, 182077.0, 182343.0, 182530.0, 41725.37411938823, 47250.5274947253, 47769.28346074742, 47871.28193077107, 47977.52022479731, 49736.502634973185, 49789.751051244515, 49805.50583482502, 49824.50175498271, 49863.0, 15366.462173823862, 15533.533993980198, 15534.689306213813, 15574.065556066445, 15576.610584735246, 12800.423980920694, 12816.166949148275, 12830.743385132246, 12851.357432128543, 12854.742905141844, 13488.5279015234, 13510.527131550349, 13533.593992180251, 13553.932230338785, 13649.317534123255, 5368.0, 5424.810131645373, 5454.0, 5473.370562385297, 5530.0, 1021.5505177721778, 1021.9540120694587, 1027.8612387327764, 1034.3690348887174, 1044.3316277582353, 22897.198598048988, 23192.65211021836, 23258.3022509325, 23373.0, 23487.739778991607, 1109.7835921995134, 1115.576081089197, 1123.3484578944192, 1126.7352172239516, 1131.5926266544038, 12205.267683938991, 12257.325847078318, 12301.446434910451, 12324.938375308066, 12422.0, 217961.0, 219721.0, 219926.0, 220205.0, 221585.0, 53544.0, 53730.73134634302, 53815.19277210845, 53850.7307463468, 53942.190867137026, 1410.4146779086768, 1442.386985531145, 1467.7798330250334, 1483.0879009409136, 1493.4996776079918, 22742.658860116782, 22796.4300892479, 23189.76810231876, 23254.3023709289, 23379.649305260096, 37097.6290237105, 37123.62876371202, 37185.814070929475, 37197.07007324838, 37197.814010929775, 181000.0, 181019.0, 182816.0, 182846.0, 182993.0, 30314.242143945696, 31155.37689246248, 31160.376792464478, 31238.843805780827, 32485.67514324921, 41438.378424323055, 43715.78142109269, 43720.78139609282, 44369.778151109036, 45031.324530132726, 31286.061418157493, 31291.374172516877, 31563.368732625677, 31938.0, 32335.514967275038, 31717.36565268728, 32023.0, 32165.678343216267, 32206.0, 32353.35293294074, 35737.82131089432, 35839.46240806442, 35983.64016359908, 36095.639043609226, 36143.27713445769, 31025.88571514146, 31610.209744756565, 31625.0, 31913.0, 32043.198920027186, 22604.66093008639, 23032.493497806165, 23235.53528929378, 23291.53416931686, 23559.175428859908], "value": 16916.81295213886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9020171469991, 568.4145330309782, 569.8917205730911, 576.7952376906198, 596.2100217212195, 22278.0, 22764.658530122062, 22931.885340573273, 22938.770612293894, 22998.195063172752, 23150.768492315114, 24426.389340266458, 24431.511369772594, 24692.259232223063, 24728.62907056391, 6272.8118156455375, 6438.227412710457, 6447.709853056624, 6451.0, 6458.838529036765, 6278.623282603058, 6306.527010474209, 6386.712597933104, 6390.041493775924, 6390.776322828702, 6551.737930482775, 6568.211814582257, 6569.540132190748, 6572.80281591553, 6578.80263592093, 6547.9017814732815, 6552.3775241352, 6559.508036897228, 6563.048357988113, 6567.047778072177, 6071.939280607226, 6681.498887583402, 6981.0, 7025.402840758542, 7050.647467626598, 29566.40867182666, 30048.849755751082, 30204.0, 30220.24449388783, 30303.696963030307, 2036.5519585691125, 2056.4036429435446, 2058.207590077831, 2059.258666879922, 2066.070268379235, 19787.604247914962, 20321.288754893507, 20761.377158685264, 20819.16723331065, 21074.789252107435, 2469.4567195217023, 2530.114459939025, 2532.341591186286, 2543.8092143089343, 2604.6353510508543, 124272.37863810714, 129550.3522482391, 129858.3507082468, 136426.999999999, 139256.0, 20396.184152634025, 20735.8963205183, 21648.0, 21887.78112218889, 22304.0, 41262.1747565053, 41376.0, 41407.58592414098, 41458.79270603628, 41478.0, 10764.623238186627, 10900.672979810619, 10940.507677154546, 10975.670729878117, 11107.500162492708, 8917.955410222907, 8996.685116020908, 9004.424225760466, 9009.23421509166, 9144.0, 11054.944725276322, 11207.71980700489, 11214.10287177024, 11275.884302229792, 11318.0, 3764.2169619532197, 4081.510218773766, 4132.876013719593, 4168.520620128724, 4482.7758612069265, 953.4755884263766, 955.4888134847823, 976.8974257702981, 987.5802783816849, 1014.264658122855, 18843.81156188448, 19195.904020480088, 19370.4188874334, 19441.708374374397, 19631.607367852564, 1035.0203467666809, 1039.3192458939407, 1039.7556574205055, 1046.2989796835986, 1053.752368193474, 10612.31019983714, 10682.839757403644, 10721.624743133953, 10842.40366779819, 10938.289011214245, 444571.0, 449570.0, 455676.0, 458732.0, 469823.0, 107630.46184769025, 108571.45714271379, 108663.0, 109819.0, 110703.0, 1040.599369242847, 1151.7063148897146, 1152.4007516091585, 1200.8558972923306, 1218.3542722357165, 19686.40940771779, 20185.6972145415, 20215.4946126348, 20328.390148295573, 20549.79450205479, 52569.21146182887, 53138.46861531335, 53259.93480130298, 53816.19275710946, 55142.17286740622, 64213.67893160504, 65015.349846502824, 65326.673366632866, 65753.0, 65772.0, 19174.233030678617, 19486.610267794847, 19531.21875124979, 19565.8043419564, 19635.0, 21961.78038219661, 22050.917337656618, 22117.225897093525, 22193.334199974026, 22650.546989060455, 17636.29454821844, 17852.10739462996, 17908.194131264387, 17954.371596994042, 18018.72971905396, 15660.765088523453, 16222.18889055566, 16348.509544713677, 16426.260818262966, 16706.248218830424, 17634.382796602058, 17834.01912894803, 17979.101044947438, 18162.45512634623, 18531.44405667778, 19296.71054934149, 19429.902850485658, 19508.414747557596, 19521.902390487958, 19792.703109453658, 17183.226754796313, 17461.12694365302, 17552.82447175512, 17568.472945811645, 17661.205245763715], "value": 12616.40594950323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.9690966640374, 1389.840168380636, 1407.6903081322105, 1415.5470249520151, 1420.4247279851656, 14532.854671453295, 15100.093994360346, 15252.542423727278, 15266.0, 15279.312430940607, 14931.925340373311, 14947.476838310662, 15001.62495937602, 15035.0, 15110.0, 2693.3132051326884, 2720.9319767005836, 2760.4755096531694, 2765.5713364428548, 2774.4451109778124, 2739.0, 2746.2036009557205, 2758.6413766210367, 2761.2682639100653, 2765.225736793701, 2639.432522007768, 2754.2425832895915, 2762.1023167470553, 2770.6813716422666, 2773.362126710858, 2500.6874140732407, 2511.836730612504, 2521.520911026899, 2524.990003998397, 2532.645429639852, 2515.9874200629065, 2543.465872166847, 2552.4767422678306, 2553.8212325137247, 2569.486102779452, 14675.853241467663, 14920.552383428514, 14921.403143874231, 14933.253337333199, 15036.774448383283, 7888.934993775824, 8179.182081791773, 8205.974253218348, 8223.342132629436, 8247.917520824774, 5101.846944591668, 5232.555232805178, 5263.394709608406, 5376.569874410077, 5382.407935127133, 1967.390109066194, 1974.5853370792152, 1979.7624285085883, 2032.756069271682, 2043.2542122125317, 26125.216243512725, 26441.074562390226, 26472.73527264722, 26500.86749566259, 26518.0, 6512.772052978123, 6724.529282950244, 6802.591844489347, 6925.272846351161, 6939.930600693929, 16630.75053874193, 17124.657506850042, 17193.484195474157, 17244.568885777957, 17282.913585431994, 7778.105517865405, 7979.241972012649, 7980.0, 7980.800479987931, 7994.880076798852, 7310.378617817439, 7382.704691812375, 7449.515781474187, 7471.514351567131, 7481.663325150382, 5091.210862316347, 5179.948200518022, 5189.221616757516, 5206.140986737146, 5363.973180134074, 1497.408523633159, 1499.242882344409, 1510.8564686354778, 1520.065159926637, 1527.4806565767692, 887.6449420231829, 906.1889608800087, 916.3860213656866, 919.6873063158558, 927.7448701607112, 7709.8458030839065, 7817.804554886174, 7826.7651970440975, 7829.569373684502, 7867.0, 715.7888422915253, 717.6519388096768, 735.5292612727858, 745.262190431469, 747.8466914282559, 4661.279058166272, 5265.605079619044, 5454.754536045887, 5497.587680923867, 5559.33288005442, 20104.195832166843, 20425.48936276575, 20549.178032878815, 21315.573688526452, 21320.466988325104, 20539.075741591365, 20548.0, 20586.0, 20728.0, 21361.465963351042, 11263.549458021751, 11355.886441135483, 11482.712932176595, 11501.53993840237, 11537.423128843524, 8341.916580834113, 8496.830063398822, 8582.399232053696, 8600.827983440422, 8632.438891472035, 18303.72544411808, 18645.881247125217, 18727.531811704815, 18850.905745471184, 19105.23579056878, 18523.062804245277, 19546.31587894417, 19614.313499027467, 20071.39785806428, 20193.091310891337, 9778.85331720039, 10134.189264858645, 10138.645147419806, 10502.894971050497, 11031.22781405326, 13416.39626216842, 13629.79555306691, 13640.181589104288, 13659.385327660479, 13677.110987785762, 11231.775364492501, 11259.718507037389, 11483.196176267915, 11485.655430337103, 11712.531498739954, 11038.734673957648, 11170.832437513607, 11214.495347709535, 11304.208705390543, 11506.654800356002, 9859.852102218329, 9976.301658884098, 9982.900170998488, 9984.500774961078, 9985.60057597688, 7547.660355284135, 7563.52511260299, 7583.431242656712, 7678.69285228607, 7690.769276921701, 7502.437317201123, 7559.8110047247055, 7590.696372145052, 7687.5387476751575, 7742.535447873146], "value": 6610.804723644161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.97342550743497, 518.6991544903956, 523.4320761973258, 525.6163001009264, 532.9014132385507, 6241.0, 6280.089387038876, 6378.521610879186, 6388.744450221986, 6420.587470756438, 6244.250689917205, 6271.341509141543, 6291.748330066792, 6318.620882747038, 6327.430531252198, 5191.818286359978, 5231.136862417697, 5237.031149237403, 5241.711705856176, 5275.28783614211, 4927.507249275061, 5179.938112686909, 5223.477652234784, 5232.73836308183, 5287.682739035651, 4913.680610760307, 4969.925451118218, 4970.950290497103, 5004.424491183524, 5030.170021946375, 4936.481669424695, 4974.27872958419, 5001.874578219908, 5010.599152067826, 5021.297018417425, 4473.217186992263, 4491.0, 4504.8198072077075, 4528.909421811578, 4529.0, 6198.442140207403, 6230.314665386803, 6234.688265586748, 6237.688115594247, 6241.282252540925, 5750.137479378127, 5814.854628634275, 5821.330546987108, 5832.883342333172, 5837.299524057098, 6559.93440065598, 6561.507886908454, 6574.769883054118, 6603.834904127387, 6622.476830329003, 4865.829695960624, 4873.658843880929, 4878.390201224847, 4888.266759985995, 4905.705657660552, 6615.305392933769, 6817.761378351784, 6863.558652682893, 6871.931280687229, 6919.266889578588, 5037.748112594356, 5048.444671086178, 5058.570021548209, 5062.139436295838, 5096.184610462383, 5091.745412729349, 5095.974520127375, 5119.206522988943, 5136.9743151284, 5141.640085194001, 5670.319561652545, 5686.744096515667, 5769.249997500298, 5772.7690892363835, 5779.653220806765, 6677.799666010027, 6685.632290223987, 6696.19645642526, 6714.496412769062, 6731.528792984444, 1762.4624489530815, 1776.360510216321, 1776.9733453998201, 1777.6977913754693, 1789.1929151557022, 1168.8597368315686, 1203.7050922524038, 1210.9091818113677, 1212.8847759462838, 1242.3043095866162, 5591.496765291144, 5669.461401166883, 5739.512141467939, 5776.104703770922, 5803.5357171426185, 6656.600603963778, 6766.69549870257, 6794.728210871609, 6887.242403335629, 6887.7244910203035, 5535.640183388067, 5590.161475778666, 5744.167095771089, 5784.1902133701315, 5796.971015144982, 3546.202104526461, 3558.1638314995957, 3574.249407624428, 3574.8033858137533, 3635.9818200908826, 6333.303336632966, 6464.062710906892, 6500.317466666026, 6535.509836762167, 6550.312217217219, 6959.304069593, 6959.61722105289, 6961.79114626562, 7003.299670032956, 7014.92985070153, 6198.776236561708, 6460.483161347175, 6492.675366231764, 6499.7400103995315, 6531.379518945692, 6476.449501792212, 6624.87377145896, 6668.633225172662, 6689.26418094019, 6698.296678848651, 6485.578437401554, 6625.0, 6642.4686025118845, 6668.299828517936, 6685.298043705341, 6319.6208227506495, 6346.540295731915, 6451.3548645135115, 6466.708998095191, 6526.967365163144, 4892.2661600760175, 5064.139096353702, 5067.77195026232, 5071.18860982241, 5090.41460232078, 6581.769638062645, 6640.535162538576, 6708.42978346846, 6895.552368722247, 6938.710225625632, 6515.087887695821, 6543.051257567721, 6629.370209830058, 6631.734730610721, 6634.668266586747, 6578.342165783383, 6602.273749887605, 6617.0, 6681.599104053772, 6683.4319082876555, 6491.935080649133, 6506.577072490273, 6552.901706474502, 6565.507586930904, 6574.389274627747, 6638.402543771083, 6680.632565208765, 6710.66446677674, 6732.562383445061, 6756.864862702817, 6489.4808415325715, 6502.642354670538, 6508.316626754312, 6509.674516274262, 6512.678533947626], "value": 5098.537091109717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.4723166100339, 912.3750231091707, 916.9954150229252, 928.8792456980591, 941.6421759731303, 19543.70684439733, 20619.27832525862, 20677.17291308348, 20697.896510517447, 20701.0, 18272.543186420346, 18869.716954245698, 18885.52786180346, 18998.525036874085, 19142.71285930712, 947.3415975896754, 966.0773960867355, 969.9466529340883, 971.5433746139339, 972.3776782858976, 956.7321150077989, 971.7084874537646, 975.7267964969819, 977.7946631207456, 996.5615129343103, 1059.35379418555, 1060.9575616975312, 1061.686802393296, 1061.8566493523392, 1062.5324857062867, 996.8006398720285, 1027.4708525109575, 1049.853020577116, 1055.145332280855, 1055.7360659835042, 755.2070326157512, 756.2324240895496, 756.7464899258755, 756.8713318735828, 757.1557713149854, 20432.387028389174, 20503.2823851166, 20604.793952060438, 20644.896775516027, 20670.689939650918, 21124.894375528023, 22579.887100564556, 22715.20496782605, 22756.317310480714, 22774.886125569265, 17262.3958161465, 17587.824121758746, 17671.293148274053, 17810.55473613157, 17820.287188512444, 3635.4183330666965, 3641.908952276188, 3651.6165802590876, 3666.5966743658178, 3671.834767435472, 141637.0, 142749.0, 143310.99999999895, 144044.0, 145966.0, 16741.6651666966, 16991.575210619587, 17036.829631703524, 17099.0, 17298.65402691939, 30929.845350773103, 31367.0, 31491.37017259642, 31638.841805790824, 31799.364012719616, 7987.720429784929, 8149.877751833727, 8204.425690201628, 8218.342532597379, 8271.875921861056, 4217.7891105444605, 4275.743455392686, 4295.52749197588, 4303.440552728125, 4314.89212769677, 5306.52241298285, 5404.432534583891, 5417.83746487606, 5431.619786614978, 5437.048516509674, 957.3203025851724, 990.3216296836546, 993.3592832622918, 1003.5484032185545, 1009.1573536097294, 697.8255436140964, 705.7381093595015, 715.1489727224587, 725.1588157737, 733.1422235983912, 10941.507632156572, 11593.0, 11632.418379081013, 11681.357525336189, 12070.577529786415, 679.1951537428164, 690.7237105157876, 691.7924622613195, 705.1256442011868, 706.9187043489961, 5560.4906726287345, 5650.378458369576, 5688.943110568925, 5701.059325211294, 5752.252207213036, 124524.0, 126945.36527317304, 127595.0, 129374.35312823564, 132761.33619331842, 110535.0, 111100.0, 113275.0, 113797.0, 114441.4277928605, 96869.0, 99380.50309748405, 99887.0, 100186.0, 102078.48960755297, 10238.488075596042, 10353.327033742782, 10476.371417714961, 10650.0, 10821.513031913426, 44113.77943110264, 44395.33406998833, 44617.0, 45099.32351014803, 45615.0, 55989.0, 57156.42843571511, 59270.0, 59572.70213648904, 59841.700791495765, 15506.9224653876, 15788.184358798886, 15897.602559936095, 16030.27863746111, 16039.599010024842, 17628.911855441154, 17775.111244437983, 17791.644167116843, 17940.461786146436, 18160.636787264444, 15876.0, 16083.356665733707, 16232.431864884673, 16256.593585160466, 16421.507354779376, 15193.164375959428, 15429.305681244146, 15491.30289136969, 15509.612259693598, 15609.921950390175, 14367.928160359132, 14713.632159196106, 14764.557063288119, 14833.554993350217, 14838.0, 11052.834207486734, 11135.832962505407, 11167.72080697989, 11309.095272378354, 11388.772224555629, 11105.722356941142, 11112.38881861473, 11160.665180044612, 11249.943750281196, 11382.317060976367], "value": 8971.013059136261, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 107.0, 106.0, 107.0, 109.0, 107.0, 107.0, 108.0, 106.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 115.0, 116.0, 117.0, 140.0, 117.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 162.0, 162.0, 161.0, 161.0, 167.0, 165.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 75.0, 75.0, 73.0, 74.0, 77.0, 73.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 78.0, 78.0, 77.0, 79.0, 79.0, 80.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 115.0, 114.0, 112.0, 114.0, 118.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 147.0, 151.0, 148.0, 149.0, 149.0, 149.0, 150.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 52.0, 53.0, 55.0, 55.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0, 37.0, 42.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 76.0, 81.0, 73.0, 78.0, 75.0, 76.0, 76.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 115.0, 115.0, 115.0, 116.0, 117.0, 110.0, 117.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 178.0, 188.0, 168.0, 174.0, 169.0, 171.0, 168.0, 174.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 66.0, 64.0, 63.0, 69.0, 70.0, 68.0], "value": 66.5, "unit": "score"}]}]} 03:15:55 INFO - Return code: 0 03:15:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:15:55 INFO - # TBPL SUCCESS # 03:15:55 INFO - Running post-action listener: _package_coverage_data 03:15:55 INFO - Running post-action listener: _resource_record_post_action 03:15:55 INFO - [mozharness: 2017-09-19 10:15:55.818450Z] Finished run-tests step (success) 03:15:55 INFO - Running post-run listener: _resource_record_post_run 03:15:55 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 337842176; Read time: 0; Write time: 179236 03:15:55 INFO - TinderboxPrint: CPU usage
13.1% 03:15:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:15:55 INFO - TinderboxPrint: I/O write bytes / time
337,842,176 / 179,236 03:15:55 INFO - TinderboxPrint: CPU idle
8,210.1 (86.9%) 03:15:55 INFO - TinderboxPrint: CPU user
1,190.4 (12.6%) 03:15:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:15:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13074432; Read time: 0; Write time: 3216 03:15:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:15:55 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 324366336; Read time: 0; Write time: 175992 03:15:56 INFO - Running post-run listener: _upload_blobber_files 03:15:56 INFO - Blob upload gear active. 03:15:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:15:56 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:15:56 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:15:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:57 INFO - (blobuploader) - INFO - Done attempting. 03:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:05 INFO - (blobuploader) - INFO - Done attempting. 03:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:06 INFO - (blobuploader) - INFO - Done attempting. 03:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:07 INFO - (blobuploader) - INFO - Done attempting. 03:16:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:07 INFO - Return code: 0 03:16:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68387c9bd9c1a22961affa7c7c7af86ea88296ddcf15f7ad63783ca69243ad4073142ac43c4b95505ec70e56fe2a12a446d3d0032402fd296140ef295f2e28f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709e2506731ebe3021fca20af758cf561c7cbb475a99eb1f788b29e2c109b618e73cfd78108c44d9c47f367f13ac5c2ae0e5202f5c165aa8368b33ce26f4ff5b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c932eef3395b267413bd4988be3e59db662c0fc3ac2ccd97030d80316e189d5e80f699c017edec6debff8e23331e329aa3e8f0efec0bbd49402f5740c515409b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a965b85685b239222bd1bbe525f0d44badc38a9106fe20ce01e531899c9eb1cfbebdd198b5ca8d5abc12dd658e72139b8ec10b3de617d2d21d729f0dd884255"} 03:16:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:07 INFO - Contents: 03:16:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68387c9bd9c1a22961affa7c7c7af86ea88296ddcf15f7ad63783ca69243ad4073142ac43c4b95505ec70e56fe2a12a446d3d0032402fd296140ef295f2e28f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709e2506731ebe3021fca20af758cf561c7cbb475a99eb1f788b29e2c109b618e73cfd78108c44d9c47f367f13ac5c2ae0e5202f5c165aa8368b33ce26f4ff5b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c932eef3395b267413bd4988be3e59db662c0fc3ac2ccd97030d80316e189d5e80f699c017edec6debff8e23331e329aa3e8f0efec0bbd49402f5740c515409b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a965b85685b239222bd1bbe525f0d44badc38a9106fe20ce01e531899c9eb1cfbebdd198b5ca8d5abc12dd658e72139b8ec10b3de617d2d21d729f0dd884255"} 03:16:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:07 INFO - Copying logs to upload dir... 03:16:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.459246 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-19 03:16:07.421337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:07.424551) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 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-Non-PGO/sha512/e68387c9bd9c1a22961affa7c7c7af86ea88296ddcf15f7ad63783ca69243ad4073142ac43c4b95505ec70e56fe2a12a446d3d0032402fd296140ef295f2e28f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709e2506731ebe3021fca20af758cf561c7cbb475a99eb1f788b29e2c109b618e73cfd78108c44d9c47f367f13ac5c2ae0e5202f5c165aa8368b33ce26f4ff5b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c932eef3395b267413bd4988be3e59db662c0fc3ac2ccd97030d80316e189d5e80f699c017edec6debff8e23331e329aa3e8f0efec0bbd49402f5740c515409b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a965b85685b239222bd1bbe525f0d44badc38a9106fe20ce01e531899c9eb1cfbebdd198b5ca8d5abc12dd658e72139b8ec10b3de617d2d21d729f0dd884255"} build_url:https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/E2iwetAjQBK55x0sv57OwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68387c9bd9c1a22961affa7c7c7af86ea88296ddcf15f7ad63783ca69243ad4073142ac43c4b95505ec70e56fe2a12a446d3d0032402fd296140ef295f2e28f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709e2506731ebe3021fca20af758cf561c7cbb475a99eb1f788b29e2c109b618e73cfd78108c44d9c47f367f13ac5c2ae0e5202f5c165aa8368b33ce26f4ff5b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c932eef3395b267413bd4988be3e59db662c0fc3ac2ccd97030d80316e189d5e80f699c017edec6debff8e23331e329aa3e8f0efec0bbd49402f5740c515409b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a965b85685b239222bd1bbe525f0d44badc38a9106fe20ce01e531899c9eb1cfbebdd198b5ca8d5abc12dd658e72139b8ec10b3de617d2d21d729f0dd884255"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:07.452553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:07.452943) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1505800235.208892-1154956384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:16:07.534606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:16:07.534902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:16:07.535221) ========= ========= Total master_lag: 0.21 =========