builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1505374406.03 results: success (0) revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.028616) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.029089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.029370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.175758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.176028) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 00:33: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% 81.9M=0s 2017-09-14 00:33:26 (81.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127496 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.337763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.338113) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016409 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.405788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.406217) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9517eea4a1a5955618fc79d039f9f0282b7185ca --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 9517eea4a1a5955618fc79d039f9f0282b7185ca --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:33:26,461 truncating revision to first 12 chars 2017-09-14 00:33:26,461 Setting DEBUG logging. 2017-09-14 00:33:26,461 attempt 1/10 2017-09-14 00:33:26,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9517eea4a1a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 00:33:26,710 unpacking tar archive at: mozilla-central-9517eea4a1a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.985467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.988825) ========= script_repo_revision: 9517eea4a1a5955618fc79d039f9f0282b7185ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.989208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:26.989463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:33:27.037360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 00:33:27.040680) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:33:27 INFO - MultiFileLogger online at 20170914 00:33:27 in /builds/slave/test 00:33:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:33:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:33:27 INFO - {'append_to_log': False, 00:33:27 INFO - 'base_work_dir': '/builds/slave/test', 00:33:27 INFO - 'blob_upload_branch': 'Firefox', 00:33:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:33:27 INFO - 'branch': 'Firefox', 00:33:27 INFO - 'buildbot_json_path': 'buildprops.json', 00:33:27 INFO - 'code_coverage': False, 00:33:27 INFO - 'config_files': ('talos/linux_config.py',), 00:33:27 INFO - 'default_actions': ('clobber', 00:33:27 INFO - 'read-buildbot-config', 00:33:27 INFO - 'download-and-extract', 00:33:27 INFO - 'populate-webroot', 00:33:27 INFO - 'create-virtualenv', 00:33:27 INFO - 'install', 00:33:27 INFO - 'setup-mitmproxy', 00:33:27 INFO - 'run-tests'), 00:33:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:33:27 INFO - 'disable_ccov_upload': False, 00:33:27 INFO - 'disable_stylo': False, 00:33:27 INFO - 'download_minidump_stackwalk': True, 00:33:27 INFO - 'download_symbols': 'ondemand', 00:33:27 INFO - 'enable_stylo': False, 00:33:27 INFO - 'enable_webrender': False, 00:33:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:33:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:33:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:33:27 INFO - 'gecko_profile': False, 00:33:27 INFO - 'gecko_profile_interval': 0, 00:33:27 INFO - 'installer_path': 'installer.exe', 00:33:27 INFO - 'log_level': 'info', 00:33:27 INFO - 'log_name': 'talos', 00:33:27 INFO - 'log_to_console': True, 00:33:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:33:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:33:27 INFO - 'opt_config_files': (), 00:33:27 INFO - 'pip_index': False, 00:33:27 INFO - 'suite': 'dromaeojs-e10s', 00:33:27 INFO - 'system_bits': '32', 00:33:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:33:27 INFO - 'title': 'talos-linux64-ix-069', 00:33:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:33:27 INFO - 'use_talos_json': True, 00:33:27 INFO - 'verify': 'False', 00:33:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:33:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:33:27 INFO - 'work_dir': 'build'} 00:33:27 INFO - [mozharness: 2017-09-14 07:33:27.239104Z] Running clobber step. 00:33:27 INFO - Running pre-action listener: _resource_record_pre_action 00:33:27 INFO - Running main action method: clobber 00:33:27 INFO - rmtree: /builds/slave/test/build 00:33:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:33:28 INFO - Running post-action listener: _resource_record_post_action 00:33:28 INFO - [mozharness: 2017-09-14 07:33:28.253468Z] Finished clobber step (success) 00:33:28 INFO - [mozharness: 2017-09-14 07:33:28.253565Z] Running read-buildbot-config step. 00:33:28 INFO - Running pre-action listener: _resource_record_pre_action 00:33:28 INFO - Running main action method: read_buildbot_config 00:33:28 INFO - Using buildbot properties: 00:33:28 INFO - { 00:33:28 INFO - "project": "", 00:33:28 INFO - "product": "firefox", 00:33:28 INFO - "who": "kwierso@gmail.com", 00:33:28 INFO - "installer_path": "public/build/target.tar.bz2", 00:33:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:33:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:33:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 00:33:28 INFO - "stage_platform": "linux64-pgo", 00:33:28 INFO - "basedir": "/builds/slave/test", 00:33:28 INFO - "buildnumber": 155, 00:33:28 INFO - "platform": "ubuntu64_hw", 00:33:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:33:28 INFO - "slavebuilddir": "test", 00:33:28 INFO - "taskId": "FMzwUSs9SH2zbMoKoMbbtA", 00:33:28 INFO - "branch": "mozilla-central", 00:33:28 INFO - "script_repo_revision": "production", 00:33:28 INFO - "revision": "9517eea4a1a5955618fc79d039f9f0282b7185ca", 00:33:28 INFO - "slavename": "talos-linux64-ix-069", 00:33:28 INFO - "repo_path": "mozilla-central" 00:33:28 INFO - } 00:33:28 INFO - Finding installer, test and symbols from parent task. 00:33:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMzwUSs9SH2zbMoKoMbbtA'}, attempt #1 00:33:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMzwUSs9SH2zbMoKoMbbtA'}, attempt #1 00:33:29 INFO - Task dependencies: A80n8hY7R3ez-LhoDFyx5Q 00:33:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q'}, attempt #1 00:33:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 00:33:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.test_packages.json 00:33:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.crashreporter-symbols.zip 00:33:29 INFO - Running post-action listener: _resource_record_post_action 00:33:29 INFO - [mozharness: 2017-09-14 07:33:29.694417Z] Finished read-buildbot-config step (success) 00:33:29 INFO - [mozharness: 2017-09-14 07:33:29.694633Z] Running download-and-extract step. 00:33:29 INFO - Running pre-action listener: _resource_record_pre_action 00:33:29 INFO - Running main action method: download_and_extract 00:33:29 INFO - mkdir: /builds/slave/test/build/tests 00:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:29 INFO - trying https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.test_packages.json 00:33:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:33:30 INFO - Downloaded 989 bytes. 00:33:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:33:30 INFO - Using the following test package requirements: 00:33:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:33:30 INFO - u'common': [u'target.common.tests.zip'], 00:33:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:33:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:33:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:33:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:33:30 INFO - u'mozbase': [u'target.common.tests.zip'], 00:33:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:33:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:33:30 INFO - u'web-platform': [u'target.common.tests.zip', 00:33:30 INFO - u'target.web-platform.tests.tar.gz'], 00:33:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:33:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.common.tests.zip 00:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:33:30 INFO - Fetch https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.common.tests.zip into memory 00:33:32 INFO - Content-Length response header: 55186363 00:33:32 INFO - Bytes received: 55186363 00:33:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.talos.tests.zip 00:33:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:33:43 INFO - Fetch https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.talos.tests.zip into memory 00:33:44 INFO - Content-Length response header: 14500356 00:33:44 INFO - Bytes received: 14500356 00:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:45 INFO - trying https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 00:33:45 INFO - Downloading https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:33:48 INFO - Downloaded 62240760 bytes. 00:33:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 00:33:48 INFO - mkdir: /builds/slave/test/properties 00:33:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:33:48 INFO - Writing to file /builds/slave/test/properties/build_url 00:33:48 INFO - Contents: 00:33:48 INFO - build_url:https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 00:33:48 INFO - Running post-action listener: _resource_record_post_action 00:33:48 INFO - Running post-action listener: find_tests_for_verification 00:33:48 INFO - Running post-action listener: set_extra_try_arguments 00:33:48 INFO - [mozharness: 2017-09-14 07:33:48.367235Z] Finished download-and-extract step (success) 00:33:48 INFO - [mozharness: 2017-09-14 07:33:48.367464Z] Running populate-webroot step. 00:33:48 INFO - Running pre-action listener: _resource_record_pre_action 00:33:48 INFO - Running main action method: populate_webroot 00:33:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:33:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['tresize', 00:33:48 INFO - 'tcanvasmark']}, 00:33:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:33:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['dromaeo_css', 00:33:48 INFO - 'kraken']}, 00:33:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'tests': ['damp', 'tps']}, 00:33:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['damp', 'tps']}, 00:33:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:33:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['dromaeo_dom']}, 00:33:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:33:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['basic_compositor_video', 00:33:48 INFO - 'glvideo']}, 00:33:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:33:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['ts_paint_webext', 00:33:48 INFO - 'tp5o_webext']}, 00:33:48 INFO - 'other-e10s': {'tests': ['a11yr', 00:33:48 INFO - 'ts_paint', 00:33:48 INFO - 'tpaint', 00:33:48 INFO - 'sessionrestore', 00:33:48 INFO - 'sessionrestore_many_windows', 00:33:48 INFO - 'sessionrestore_no_auto_restore', 00:33:48 INFO - 'tabpaint']}, 00:33:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['a11yr', 00:33:48 INFO - 'ts_paint', 00:33:48 INFO - 'tpaint', 00:33:48 INFO - 'sessionrestore', 00:33:48 INFO - 'sessionrestore_many_windows', 00:33:48 INFO - 'sessionrestore_no_auto_restore', 00:33:48 INFO - 'tabpaint']}, 00:33:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:33:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:33:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['bloom_basic_singleton']}, 00:33:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['bloom_basic']}, 00:33:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:33:48 INFO - 'tsvgr_opacity', 00:33:48 INFO - 'tart', 00:33:48 INFO - 'tscrollx', 00:33:48 INFO - 'tsvg_static']}, 00:33:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['tsvgx', 00:33:48 INFO - 'tsvgr_opacity', 00:33:48 INFO - 'tart', 00:33:48 INFO - 'tscrollx', 00:33:48 INFO - 'tsvg_static']}, 00:33:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:33:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo'], 00:33:48 INFO - 'tests': ['tp5o']}, 00:33:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:33:48 INFO - 'talos_options': ['--mitmproxy', 00:33:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:33:48 INFO - '--firstNonBlankPaint'], 00:33:48 INFO - 'tests': ['tp6_google', 00:33:48 INFO - 'tp6_youtube', 00:33:48 INFO - 'tp6_amazon', 00:33:48 INFO - 'tp6_facebook']}, 00:33:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo', 00:33:48 INFO - '--mitmproxy', 00:33:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:33:48 INFO - '--firstNonBlankPaint'], 00:33:48 INFO - 'tests': ['tp6_google', 00:33:48 INFO - 'tp6_youtube', 00:33:48 INFO - 'tp6_amazon', 00:33:48 INFO - 'tp6_facebook']}, 00:33:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:33:48 INFO - 'talos_options': ['--stylo-threads=1', 00:33:48 INFO - '--mitmproxy', 00:33:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:33:48 INFO - '--firstNonBlankPaint'], 00:33:48 INFO - 'tests': ['tp6_google', 00:33:48 INFO - 'tp6_youtube', 00:33:48 INFO - 'tp6_amazon', 00:33:48 INFO - 'tp6_facebook']}, 00:33:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--xperf_path', 00:33:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:48 INFO - 'tests': ['tp5n']}, 00:33:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:33:48 INFO - 'talos_options': ['--disable-stylo', 00:33:48 INFO - '--xperf_path', 00:33:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:48 INFO - 'tests': ['tp5n']}}} 00:33:48 INFO - Running post-action listener: _resource_record_post_action 00:33:48 INFO - [mozharness: 2017-09-14 07:33:48.394100Z] Finished populate-webroot step (success) 00:33:48 INFO - [mozharness: 2017-09-14 07:33:48.394190Z] Running create-virtualenv step. 00:33:48 INFO - Running pre-action listener: _resource_record_pre_action 00:33:48 INFO - Running main action method: create_virtualenv 00:33:48 INFO - Creating virtualenv /builds/slave/test/build/venv 00:33:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:33:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:33:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:33:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:33:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:33:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:33:49 INFO - Installing pip...............done. 00:33:49 INFO - Return code: 0 00:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:33:49 INFO - Reading from file tmpfile_stdout 00:33:49 INFO - Output received: 00:33:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 00:33:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:33:49 INFO - Using env: {'DISPLAY': ':0', 00:33:49 INFO - 'HOME': '/home/cltbld', 00:33:49 INFO - 'LANG': 'en_US.UTF-8', 00:33:49 INFO - 'LANGUAGE': 'en_US:en', 00:33:49 INFO - 'LOGNAME': 'cltbld', 00:33:49 INFO - 'MAIL': '/var/mail/cltbld', 00:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:49 INFO - 'MOZ_NO_REMOTE': '1', 00:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:49 INFO - 'NO_EM_RESTART': '1', 00:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:49 INFO - 'PWD': '/builds/slave/test', 00:33:49 INFO - 'SHELL': '/bin/bash', 00:33:49 INFO - 'SHLVL': '1', 00:33:49 INFO - 'TERM': 'linux', 00:33:49 INFO - 'TMOUT': '86400', 00:33:49 INFO - 'USER': 'cltbld', 00:33:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:49 INFO - '_': '/tools/buildbot/bin/python'} 00:33:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:33:50 INFO - Downloading/unpacking pip>=1.5 00:33:50 INFO - Running setup.py egg_info for package pip 00:33:50 INFO - warning: no files found matching 'pip/cacert.pem' 00:33:50 INFO - warning: no files found matching '*.html' under directory 'docs' 00:33:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:33:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:33:50 INFO - Installing collected packages: pip 00:33:50 INFO - Found existing installation: pip 1.1 00:33:50 INFO - Uninstalling pip: 00:33:50 INFO - Successfully uninstalled pip 00:33:50 INFO - Running setup.py install for pip 00:33:50 INFO - warning: no files found matching 'pip/cacert.pem' 00:33:50 INFO - warning: no files found matching '*.html' under directory 'docs' 00:33:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:33:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:33:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:33:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:33:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:33:50 INFO - Successfully installed pip 00:33:50 INFO - Cleaning up... 00:33:50 INFO - Return code: 0 00:33:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:33: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')]} 00:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33: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')]} 00:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33: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', '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 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 00:33: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 psutil>=3.1.1 00:33:50 INFO - Using env: {'DISPLAY': ':0', 00:33:50 INFO - 'HOME': '/home/cltbld', 00:33:50 INFO - 'LANG': 'en_US.UTF-8', 00:33:50 INFO - 'LANGUAGE': 'en_US:en', 00:33:50 INFO - 'LOGNAME': 'cltbld', 00:33:50 INFO - 'MAIL': '/var/mail/cltbld', 00:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:50 INFO - 'MOZ_NO_REMOTE': '1', 00:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:50 INFO - 'NO_EM_RESTART': '1', 00:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:50 INFO - 'PWD': '/builds/slave/test', 00:33:50 INFO - 'SHELL': '/bin/bash', 00:33:50 INFO - 'SHLVL': '1', 00:33:50 INFO - 'TERM': 'linux', 00:33:50 INFO - 'TMOUT': '86400', 00:33:50 INFO - 'USER': 'cltbld', 00:33:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:50 INFO - '_': '/tools/buildbot/bin/python'} 00:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:50 INFO - Downloading/unpacking psutil>=3.1.1 00:33:50 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 00:33:50 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 00:33:50 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 00:33:50 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 00:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:33:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:52 INFO - Installing collected packages: psutil 00:33:52 INFO - Running setup.py install for psutil 00:33:52 INFO - building 'psutil._psutil_linux' extension 00:33:52 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 00:33:52 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 00:33:52 INFO - building 'psutil._psutil_posix' extension 00:33:52 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 00:33:52 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 00:33:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:52 INFO - Successfully installed psutil 00:33:52 INFO - Cleaning up... 00:33:52 INFO - Return code: 0 00:33:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:33: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')]} 00:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33: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')]} 00:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:33: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 mozsystemmonitor==0.3 00:33:52 INFO - Using env: {'DISPLAY': ':0', 00:33:52 INFO - 'HOME': '/home/cltbld', 00:33:52 INFO - 'LANG': 'en_US.UTF-8', 00:33:52 INFO - 'LANGUAGE': 'en_US:en', 00:33:52 INFO - 'LOGNAME': 'cltbld', 00:33:52 INFO - 'MAIL': '/var/mail/cltbld', 00:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:52 INFO - 'MOZ_NO_REMOTE': '1', 00:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:52 INFO - 'NO_EM_RESTART': '1', 00:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:52 INFO - 'PWD': '/builds/slave/test', 00:33:52 INFO - 'SHELL': '/bin/bash', 00:33:52 INFO - 'SHLVL': '1', 00:33:52 INFO - 'TERM': 'linux', 00:33:52 INFO - 'TMOUT': '86400', 00:33:52 INFO - 'USER': 'cltbld', 00:33:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:52 INFO - '_': '/tools/buildbot/bin/python'} 00:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:33: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 00:33: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 00:33: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 00:33: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 00:33:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:33:53 INFO - Installing collected packages: mozsystemmonitor 00:33:53 INFO - Running setup.py install for mozsystemmonitor 00:33:54 INFO - Successfully installed mozsystemmonitor 00:33:54 INFO - Cleaning up... 00:33:55 INFO - Return code: 0 00:33:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:33:55 INFO - Using env: {'DISPLAY': ':0', 00:33:55 INFO - 'HOME': '/home/cltbld', 00:33:55 INFO - 'LANG': 'en_US.UTF-8', 00:33:55 INFO - 'LANGUAGE': 'en_US:en', 00:33:55 INFO - 'LOGNAME': 'cltbld', 00:33:55 INFO - 'MAIL': '/var/mail/cltbld', 00:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:55 INFO - 'MOZ_NO_REMOTE': '1', 00:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:55 INFO - 'NO_EM_RESTART': '1', 00:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:55 INFO - 'PWD': '/builds/slave/test', 00:33:55 INFO - 'SHELL': '/bin/bash', 00:33:55 INFO - 'SHLVL': '1', 00:33:55 INFO - 'TERM': 'linux', 00:33:55 INFO - 'TMOUT': '86400', 00:33:55 INFO - 'USER': 'cltbld', 00:33:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:55 INFO - '_': '/tools/buildbot/bin/python'} 00:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:55 INFO - Downloading/unpacking jsonschema==2.5.1 00:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:33:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:33: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 00:33: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 00:33: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 00:33: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 00:33:56 INFO - Downloading functools32-3.2.3-2.tar.gz 00:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:33:56 INFO - warning: no files found matching '*.txt' 00:33:56 INFO - no previously-included directories found matching 'build' 00:33:56 INFO - no previously-included directories found matching 'dist' 00:33:56 INFO - no previously-included directories found matching '.git*' 00:33:56 INFO - Installing collected packages: jsonschema, functools32 00:33:57 INFO - Running setup.py install for functools32 00:33:57 INFO - warning: no files found matching '*.txt' 00:33:57 INFO - no previously-included directories found matching 'build' 00:33:57 INFO - no previously-included directories found matching 'dist' 00:33:57 INFO - no previously-included directories found matching '.git*' 00:33:57 INFO - Successfully installed jsonschema functools32 00:33:57 INFO - Cleaning up... 00:33:57 INFO - Return code: 0 00:33:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:33:57 INFO - Using env: {'DISPLAY': ':0', 00:33:57 INFO - 'HOME': '/home/cltbld', 00:33:57 INFO - 'LANG': 'en_US.UTF-8', 00:33:57 INFO - 'LANGUAGE': 'en_US:en', 00:33:57 INFO - 'LOGNAME': 'cltbld', 00:33:57 INFO - 'MAIL': '/var/mail/cltbld', 00:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:57 INFO - 'MOZ_NO_REMOTE': '1', 00:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:57 INFO - 'NO_EM_RESTART': '1', 00:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:57 INFO - 'PWD': '/builds/slave/test', 00:33:57 INFO - 'SHELL': '/bin/bash', 00:33:57 INFO - 'SHLVL': '1', 00:33:57 INFO - 'TERM': 'linux', 00:33:57 INFO - 'TMOUT': '86400', 00:33:57 INFO - 'USER': 'cltbld', 00:33:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:57 INFO - '_': '/tools/buildbot/bin/python'} 00:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:33:59 INFO - Cleaning up... 00:33:59 INFO - Return code: 0 00:33:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:33:59 INFO - Using env: {'DISPLAY': ':0', 00:33:59 INFO - 'HOME': '/home/cltbld', 00:33:59 INFO - 'LANG': 'en_US.UTF-8', 00:33:59 INFO - 'LANGUAGE': 'en_US:en', 00:33:59 INFO - 'LOGNAME': 'cltbld', 00:33:59 INFO - 'MAIL': '/var/mail/cltbld', 00:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:59 INFO - 'MOZ_NO_REMOTE': '1', 00:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:59 INFO - 'NO_EM_RESTART': '1', 00:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:59 INFO - 'PWD': '/builds/slave/test', 00:33:59 INFO - 'SHELL': '/bin/bash', 00:33:59 INFO - 'SHLVL': '1', 00:33:59 INFO - 'TERM': 'linux', 00:33:59 INFO - 'TMOUT': '86400', 00:33:59 INFO - 'USER': 'cltbld', 00:33:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:59 INFO - '_': '/tools/buildbot/bin/python'} 00:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:59 INFO - Downloading/unpacking blobuploader==1.2.4 00:33: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 00:33: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 00:33: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 00:33: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 00:34:00 INFO - Downloading blobuploader-1.2.4.tar.gz 00:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:34:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:34: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 00:34: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 00:34: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 00:34: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 00:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:34:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:01 INFO - Downloading docopt-0.6.1.tar.gz 00:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:34:01 INFO - Installing collected packages: blobuploader, requests, docopt 00:34:01 INFO - Running setup.py install for blobuploader 00:34:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:34:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:34:01 INFO - Running setup.py install for requests 00:34:01 INFO - Running setup.py install for docopt 00:34:02 INFO - Successfully installed blobuploader requests docopt 00:34:02 INFO - Cleaning up... 00:34:02 INFO - Return code: 0 00:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:34:02 INFO - Using env: {'DISPLAY': ':0', 00:34:02 INFO - 'HOME': '/home/cltbld', 00:34:02 INFO - 'LANG': 'en_US.UTF-8', 00:34:02 INFO - 'LANGUAGE': 'en_US:en', 00:34:02 INFO - 'LOGNAME': 'cltbld', 00:34:02 INFO - 'MAIL': '/var/mail/cltbld', 00:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:02 INFO - 'MOZ_NO_REMOTE': '1', 00:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:02 INFO - 'NO_EM_RESTART': '1', 00:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:02 INFO - 'PWD': '/builds/slave/test', 00:34:02 INFO - 'SHELL': '/bin/bash', 00:34:02 INFO - 'SHLVL': '1', 00:34:02 INFO - 'TERM': 'linux', 00:34:02 INFO - 'TMOUT': '86400', 00:34:02 INFO - 'USER': 'cltbld', 00:34:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:02 INFO - '_': '/tools/buildbot/bin/python'} 00:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:34:02 INFO - Running setup.py (path:/tmp/pip-mIxzXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:34:02 INFO - Running setup.py (path:/tmp/pip-HXo4Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:34:02 INFO - Running setup.py (path:/tmp/pip-QmndQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:34:02 INFO - Running setup.py (path:/tmp/pip-HA82p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:34:02 INFO - Running setup.py (path:/tmp/pip-Q6kc8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:34:02 INFO - Running setup.py (path:/tmp/pip-iWk6JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:34:02 INFO - Running setup.py (path:/tmp/pip-Z4YFck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:34:02 INFO - Running setup.py (path:/tmp/pip-3f57Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:34:02 INFO - Running setup.py (path:/tmp/pip-_1UmFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:34:02 INFO - Running setup.py (path:/tmp/pip-InjjmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:34:03 INFO - Running setup.py (path:/tmp/pip-oZ9x3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:34:03 INFO - Running setup.py (path:/tmp/pip-YZZNWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:34:03 INFO - Running setup.py (path:/tmp/pip-lvoKrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:34:03 INFO - Running setup.py (path:/tmp/pip-l0bBOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:03 INFO - Running setup.py (path:/tmp/pip-ukALc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:34:03 INFO - Running setup.py (path:/tmp/pip-B3gKWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:34:03 INFO - Running setup.py (path:/tmp/pip-PZ8lNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:34:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:34:03 INFO - Running setup.py install for manifestparser 00:34:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:34:03 INFO - Running setup.py install for mozcrash 00:34:03 INFO - Running setup.py install for mozdebug 00:34:03 INFO - Running setup.py install for mozdevice 00:34:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:34:03 INFO - Running setup.py install for mozfile 00:34:04 INFO - Running setup.py install for mozhttpd 00:34:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozinfo 00:34:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozInstall 00:34:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozleak 00:34:04 INFO - Running setup.py install for mozlog 00:34:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for moznetwork 00:34:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozprocess 00:34:04 INFO - Running setup.py install for mozprofile 00:34:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozrunner 00:34:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Running setup.py install for mozscreenshot 00:34:05 INFO - Running setup.py install for moztest 00:34:05 INFO - Running setup.py install for mozversion 00:34:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:34:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:34:05 INFO - Cleaning up... 00:34:05 INFO - Return code: 0 00:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:34:05 INFO - Using env: {'DISPLAY': ':0', 00:34:05 INFO - 'HOME': '/home/cltbld', 00:34:05 INFO - 'LANG': 'en_US.UTF-8', 00:34:05 INFO - 'LANGUAGE': 'en_US:en', 00:34:05 INFO - 'LOGNAME': 'cltbld', 00:34:05 INFO - 'MAIL': '/var/mail/cltbld', 00:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:05 INFO - 'MOZ_NO_REMOTE': '1', 00:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:05 INFO - 'NO_EM_RESTART': '1', 00:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:05 INFO - 'PWD': '/builds/slave/test', 00:34:05 INFO - 'SHELL': '/bin/bash', 00:34:05 INFO - 'SHLVL': '1', 00:34:05 INFO - 'TERM': 'linux', 00:34:05 INFO - 'TMOUT': '86400', 00:34:05 INFO - 'USER': 'cltbld', 00:34:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:05 INFO - '_': '/tools/buildbot/bin/python'} 00:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:34:05 INFO - Running setup.py (path:/tmp/pip-lB5UQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:34:05 INFO - Running setup.py (path:/tmp/pip-FUqq2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:34:05 INFO - Running setup.py (path:/tmp/pip-kDMJrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:34:05 INFO - Running setup.py (path:/tmp/pip-yqobSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:34:05 INFO - Running setup.py (path:/tmp/pip-zMvC6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:34:05 INFO - Running setup.py (path:/tmp/pip-skQ2Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:34:05 INFO - Running setup.py (path:/tmp/pip-Q30waZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:34:06 INFO - Running setup.py (path:/tmp/pip-_9o5Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:34:06 INFO - Running setup.py (path:/tmp/pip-eTW6RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:34:06 INFO - Running setup.py (path:/tmp/pip-w5GrFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:34:06 INFO - Running setup.py (path:/tmp/pip-qhviuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:34:06 INFO - Running setup.py (path:/tmp/pip-MKK3OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:34:06 INFO - Running setup.py (path:/tmp/pip-hy7VEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:34:06 INFO - Running setup.py (path:/tmp/pip-HEv3ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:06 INFO - Running setup.py (path:/tmp/pip-K6MCHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:34:06 INFO - Running setup.py (path:/tmp/pip-ZvYaW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:34:06 INFO - Running setup.py (path:/tmp/pip-ntNZ6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:34:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:07 INFO - Downloading blessings-1.6.tar.gz 00:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:34:07 INFO - Installing collected packages: blessings 00:34:07 INFO - Running setup.py install for blessings 00:34:08 INFO - Successfully installed blessings 00:34:08 INFO - Cleaning up... 00:34:08 INFO - Return code: 0 00:34:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:34:08 INFO - Reading from file tmpfile_stdout 00:34:08 INFO - Current package versions: 00:34:08 INFO - argparse == 1.2.1 00:34:08 INFO - blessings == 1.6 00:34:08 INFO - blobuploader == 1.2.4 00:34:08 INFO - docopt == 0.6.1 00:34:08 INFO - functools32 == 3.2.3-2 00:34:08 INFO - jsonschema == 2.5.1 00:34:08 INFO - manifestparser == 1.1 00:34:08 INFO - mozInstall == 1.13 00:34:08 INFO - mozcrash == 1.0 00:34:08 INFO - mozdebug == 0.1 00:34:08 INFO - mozdevice == 0.51 00:34:08 INFO - mozfile == 1.2 00:34:08 INFO - mozhttpd == 0.7 00:34:08 INFO - mozinfo == 0.10 00:34:08 INFO - mozleak == 0.1 00:34:08 INFO - mozlog == 3.5 00:34:08 INFO - moznetwork == 0.27 00:34:08 INFO - mozprocess == 0.25 00:34:08 INFO - mozprofile == 0.28 00:34:08 INFO - mozrunner == 6.13 00:34:08 INFO - mozscreenshot == 0.1 00:34:08 INFO - mozsystemmonitor == 0.3 00:34:08 INFO - moztest == 0.8 00:34:08 INFO - mozversion == 1.4 00:34:08 INFO - psutil == 3.1.1 00:34:08 INFO - requests == 1.2.3 00:34:08 INFO - wsgiref == 0.1.2 00:34:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:34:08 INFO - Using env: {'DISPLAY': ':0', 00:34:08 INFO - 'HOME': '/home/cltbld', 00:34:08 INFO - 'LANG': 'en_US.UTF-8', 00:34:08 INFO - 'LANGUAGE': 'en_US:en', 00:34:08 INFO - 'LOGNAME': 'cltbld', 00:34:08 INFO - 'MAIL': '/var/mail/cltbld', 00:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:08 INFO - 'MOZ_NO_REMOTE': '1', 00:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:08 INFO - 'NO_EM_RESTART': '1', 00:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:08 INFO - 'PWD': '/builds/slave/test', 00:34:08 INFO - 'SHELL': '/bin/bash', 00:34:08 INFO - 'SHLVL': '1', 00:34:08 INFO - 'TERM': 'linux', 00:34:08 INFO - 'TMOUT': '86400', 00:34:08 INFO - 'USER': 'cltbld', 00:34:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:08 INFO - '_': '/tools/buildbot/bin/python'} 00:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:34:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:34:09 INFO - Installing collected packages: simplejson 00:34:09 INFO - Running setup.py install for simplejson 00:34:09 INFO - building 'simplejson._speedups' extension 00:34:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 00:34:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 00:34:10 INFO - Successfully installed simplejson 00:34:10 INFO - Cleaning up... 00:34:10 INFO - Return code: 0 00:34:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', '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 00:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:34:10 INFO - Using env: {'DISPLAY': ':0', 00:34:10 INFO - 'HOME': '/home/cltbld', 00:34:10 INFO - 'LANG': 'en_US.UTF-8', 00:34:10 INFO - 'LANGUAGE': 'en_US:en', 00:34:10 INFO - 'LOGNAME': 'cltbld', 00:34:10 INFO - 'MAIL': '/var/mail/cltbld', 00:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:10 INFO - 'MOZ_NO_REMOTE': '1', 00:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:10 INFO - 'NO_EM_RESTART': '1', 00:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:10 INFO - 'PWD': '/builds/slave/test', 00:34:10 INFO - 'SHELL': '/bin/bash', 00:34:10 INFO - 'SHLVL': '1', 00:34:10 INFO - 'TERM': 'linux', 00:34:10 INFO - 'TMOUT': '86400', 00:34:10 INFO - 'USER': 'cltbld', 00:34:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:10 INFO - '_': '/tools/buildbot/bin/python'} 00:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:34:10 INFO - Cleaning up... 00:34:10 INFO - Return code: 0 00:34:10 INFO - Running post-action listener: _resource_record_post_action 00:34:10 INFO - Running post-action listener: _start_resource_monitoring 00:34:10 INFO - Starting resource monitoring. 00:34:10 INFO - [mozharness: 2017-09-14 07:34:10.987583Z] Finished create-virtualenv step (success) 00:34:10 INFO - [mozharness: 2017-09-14 07:34:10.988096Z] Running install step. 00:34:10 INFO - Running pre-action listener: _resource_record_pre_action 00:34:10 INFO - Running main action method: install 00:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:34:11 INFO - Reading from file tmpfile_stdout 00:34:11 INFO - Detecting whether we're running mozinstall >=1.0... 00:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:34:11 INFO - Reading from file tmpfile_stdout 00:34:11 INFO - Output received: 00:34:11 INFO - Usage: mozinstall [options] installer 00:34:11 INFO - Options: 00:34:11 INFO - -h, --help show this help message and exit 00:34:11 INFO - -d DEST, --destination=DEST 00:34:11 INFO - Directory to install application into. [default: 00:34:11 INFO - "/builds/slave/test"] 00:34:11 INFO - --app=APP Application being installed. [default: firefox] 00:34:11 INFO - mkdir: /builds/slave/test/build/application 00:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:34:28 INFO - Reading from file tmpfile_stdout 00:34:28 INFO - Output received: 00:34:28 INFO - /builds/slave/test/build/application/firefox/firefox 00:34:28 INFO - Running post-action listener: _resource_record_post_action 00:34:28 INFO - [mozharness: 2017-09-14 07:34:28.919205Z] Finished install step (success) 00:34:28 INFO - [mozharness: 2017-09-14 07:34:28.919457Z] Running setup-mitmproxy step. 00:34:28 INFO - Running pre-action listener: _resource_record_pre_action 00:34:28 INFO - Running main action method: setup_mitmproxy 00:34:28 INFO - Skipping: mitmproxy is not required 00:34:28 INFO - Running post-action listener: _resource_record_post_action 00:34:28 INFO - [mozharness: 2017-09-14 07:34:28.920599Z] Finished setup-mitmproxy step (success) 00:34:28 INFO - [mozharness: 2017-09-14 07:34:28.920820Z] Running run-tests step. 00:34:28 INFO - Running pre-action listener: _resource_record_pre_action 00:34:28 INFO - Running pre-action listener: _set_gcov_prefix 00:34:28 INFO - Running main action method: run_tests 00:34:28 WARNING - Try message not found. 00:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:34:28 INFO - Python 2.7.3 00:34:28 INFO - Return code: 0 00:34:28 INFO - grabbing minidump binary from tooltool 00:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:34:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e090>, '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 0x276ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2768f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:34:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:34:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:34:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:34:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:34:29 INFO - Return code: 0 00:34:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:34:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:34:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:34:29 INFO - ENV: RUST_BACKTRACE is now full 00:34:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:34:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 00:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 00:34:29 INFO - Using env: {'DISPLAY': ':0', 00:34:29 INFO - 'HOME': '/home/cltbld', 00:34:29 INFO - 'LANG': 'en_US.UTF-8', 00:34:29 INFO - 'LANGUAGE': 'en_US:en', 00:34:29 INFO - 'LOGNAME': 'cltbld', 00:34:29 INFO - 'MAIL': '/var/mail/cltbld', 00:34:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:34:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:29 INFO - 'MOZ_NO_REMOTE': '1', 00:34:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:29 INFO - 'NO_EM_RESTART': '1', 00:34:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:29 INFO - 'PWD': '/builds/slave/test', 00:34:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:34:29 INFO - 'RUST_BACKTRACE': 'full', 00:34:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:34:29 INFO - 'SHELL': '/bin/bash', 00:34:29 INFO - 'SHLVL': '1', 00:34:29 INFO - 'TERM': 'linux', 00:34:29 INFO - 'TMOUT': '86400', 00:34:29 INFO - 'USER': 'cltbld', 00:34:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:29 INFO - '_': '/tools/buildbot/bin/python'} 00:34:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 00:34:29 INFO - mozversion application_buildid: 20170914061749 00:34:29 INFO - mozversion application_changeset: 9517eea4a1a5955618fc79d039f9f0282b7185ca 00:34:29 INFO - mozversion application_display_name: Nightly 00:34:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:34:29 INFO - mozversion application_name: Firefox 00:34:29 INFO - mozversion application_remotingname: firefox 00:34:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:34:29 INFO - mozversion application_vendor: Mozilla 00:34:29 INFO - mozversion application_version: 57.0a1 00:34:29 INFO - mozversion platform_buildid: 20170914061749 00:34:29 INFO - mozversion platform_changeset: 9517eea4a1a5955618fc79d039f9f0282b7185ca 00:34:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:34:29 INFO - mozversion platform_version: 57.0a1 00:34:29 INFO - using testdate: 1505374469 00:34:29 INFO - actual date: 1505374469 00:34:29 INFO - starting webserver on 'localhost:59880' 00:34:29 INFO - SUITE-START | Running 2 tests 00:34:29 INFO - TEST-START | dromaeo_css 00:34:29 INFO - Initialising browser for dromaeo_css test... 00:34:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59880/getInfo.html -profile /tmp/tmptWUeKG/profile 00:34:29 INFO - TEST-INFO | started process 24205 (/builds/slave/test/build/application/firefox/firefox http://localhost:59880/getInfo.html) 00:34:34 INFO - TEST-INFO | 24205: exit 0 00:34:34 INFO - Browser initialized. 00:34:34 INFO - Running cycle 1/1 for dromaeo_css test... 00:34:34 INFO - Using env: {'DISPLAY': ':0', 00:34:34 INFO - 'HOME': '/home/cltbld', 00:34:34 INFO - 'JSGC_DISABLE_POISONING': '1', 00:34:34 INFO - 'LANG': 'en_US.UTF-8', 00:34:34 INFO - 'LANGUAGE': 'en_US:en', 00:34:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:34:34 INFO - 'LOGNAME': 'cltbld', 00:34:34 INFO - 'MAIL': '/var/mail/cltbld', 00:34:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:34:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:34:34 INFO - 'MOZ_CRASHREPORTER': '1', 00:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:34:34 INFO - 'MOZ_NO_REMOTE': '1', 00:34:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:34 INFO - 'NO_EM_RESTART': '1', 00:34:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:34 INFO - 'PWD': '/builds/slave/test', 00:34:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:34:34 INFO - 'RUST_BACKTRACE': 'full', 00:34:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:34:34 INFO - 'SHELL': '/bin/bash', 00:34:34 INFO - 'SHLVL': '1', 00:34:34 INFO - 'TERM': 'linux', 00:34:34 INFO - 'TMOUT': '86400', 00:34:34 INFO - 'USER': 'cltbld', 00:34:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:34 INFO - '_': '/tools/buildbot/bin/python'} 00:34:34 INFO - TEST-INFO | started process 24442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptWUeKG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:34:35 INFO - PID 24442 | 00:34:35 INFO - PID 24442 | (/builds/slave/test/build/application/firefox/firefox:24492): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:34:35 INFO - PID 24442 | 00:34:46 INFO - PID 24442 | RSS: Main: 166506496 00:34:46 INFO - PID 24442 | 00:37:43 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59880/tests/dromaeo/cssquery-ext.html) 00:37:45 INFO - PID 24442 | RSS: Main: 169320448 00:37:45 INFO - PID 24442 | 00:40:46 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-ext.html (next: http://localhost:59880/tests/dromaeo/cssquery-jquery.html) 00:40:47 INFO - PID 24442 | RSS: Main: 164630528 00:40:47 INFO - PID 24442 | 00:43:49 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59880/tests/dromaeo/cssquery-mootools.html) 00:43:49 INFO - PID 24442 | RSS: Main: 167899136 00:43:49 INFO - PID 24442 | 00:46:51 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59880/tests/dromaeo/cssquery-prototype.html) 00:46:51 INFO - PID 24442 | RSS: Main: 166744064 00:46:51 INFO - PID 24442 | 00:49:54 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59880/tests/dromaeo/cssquery-yui.html) 00:49:55 INFO - PID 24442 | RSS: Main: 168595456 00:49:55 INFO - PID 24442 | 00:52:56 INFO - PID 24442 | Cycle 1(1): loaded http://localhost:59880/tests/dromaeo/cssquery-yui.html (next: http://localhost:59880/tests/dromaeo/cssquery-dojo.html) 00:52:57 INFO - PID 24442 | RSS: Main: 171085824 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | __start_tp_report 00:52:57 INFO - PID 24442 | _x_x_mozilla_page_load 00:52:57 INFO - PID 24442 | _x_x_mozilla_page_load_details 00:52:57 INFO - PID 24442 | |i|pagename|runs| 00:52:57 INFO - PID 24442 | |0;dojo.html;3799.981000095;3816.675582575481;3819.866304679336;3825.4835597194406;3841.6926645868334;6071.60534565253;6153;6221.502279817615;6245.437910588046;6267.561270711047;6038.87922241556;6161.722722477488;6216.968915155429;6237.095621134944;6239.844003899905;5430.619856610019;5501.807436739715;5602.663840169583;5613.80351687691;5624.746886390102;5580.330360356763;5617.8033768818095;5622.184783206453;5647.068233741427;5691.971540142294;5320.76056577455;5509.862253443656;5577.386487486373;5596.328440587135;5712.028955077647;5501.257330260403;5507.779688812443;5541.695206763627;5601.915971260434;5602.523785478239;5542.11326187812;5594.944050559483;5597.132444471114;5597.776088956437;5608.2428872102155;6114.1745864308195;6154.569180157391;6166.290876549209;6251.187345645037;6253.843653908643;6675.432588230006;6675.666216689195;6777.93222067778;6799.4900382471515;6805.353491418307;6757.594544327356;6766.864662706767;6841.897371539431;6855.725770969155;6873.5875847448815;6186.133941248228;6269.3730626937395;6286.057091436275;6292;6387.457066149383;6897.827554311182;6902.240753517109;6904.067950826574;6907.481938854606;6913;6524.380183882524;6544.312847150981;6629.602223866487;6632.1709786276715;6668.33316668339;6716.697748601325;6763.0193621924545;6766.120404347404;6831.04365388846;6838.384545390939;6678.83302917431;6698.162729658793;6777.288384719632;6784.0841486399695;6787;6610;6688.33116688337;6714.194296684429;6717.630530320879;6808.455323574102;4927.039227350704;4931.457539670633;4936.802527898843;4970.403551573834;4991.326170966946;4579.152856721517;4591.196540605448;4618.307253911873;4622.075584883037;4628.861134165981;6237.220347456568;6241.843953901189;6242.063690446469;6317.715702793385;6336.461400780985;6642.867142657216;6690.565113267622;6707.865842683119;6742.393184613408;6785.2536221016635;6178.135061091451;6184.783532576428;6203.2556093269095;6203.689815509207;6206;5298.417174110845;5432.212329212242;5438.129899216106;5441.59188060897;5442.727863606804;6842.7605033823575;6842.794716158523;6894.724211031503;6963.1296087989;6971.895421568681;6594.373534514213;6681.398674119353;6696.799096027127;6697.229818570927;6744.527883048139;6856.040154378491;6866.588004719732;6924.723011079501;6948.444124469929;6960.79117626472;6603.80188594343;6614.206295244601;6614.801555953329;6683.997400389981;6704.83237919056;6631.734730610721;6665.200175978914;6669.066330713801;6765.526413151032;6772.864542709217;6496.935030649822;6512.837179070561;6513.641749703812;6514.990176522647;6521.087047813215;6425.132607097982;6448.935510644834;6491.902621460777;6504.317046710216;6508.837279067871;6419.903701444576;6500.057491663777;6511.544191906521;6511.837204069936;6521.315261897622;6493.8701225976165;6527.51043671717;6559.212894452697;6622.867542649216;6647.867042659216;6243.906341404973;6273.498120150468;6318;6335.619862808247;6417.582857114273 00:52:57 INFO - PID 24442 | |1;ext.html;952.5665822050968;974.1914211204701;979.2166266986409;979.6375341123785;981.9852702209466;40117.1976560469;43781.78109109454;44076.55923440764;44148.77925610368;44194.558054419445;42753;42780.35829462561;42820.14359712804;42852.14295714084;43100.568994310044;7378.225286344937;7455.925440745577;7973.282404583586;8125.75622731319;8157;7999.080105787822;8056.637451314676;8056.879146812803;8057.1539988301265;8064.556449395281;8043.075046369655;8113.675452981903;8138.064122625885;8144.1448647892;8146.26683598476;8081.878771818428;8085.919140808604;8087.676492940275;8091.959540202321;8115.95942020292;7985.640646170878;8027.478213916135;8033.477823941425;8037.115917249098;8039.155888631726;39596;39739.00652483682;39841.203175936316;39891.40162897559;39891.60108398908;3662.5238718966366;3706.703463722896;3711.480392745018;3711.6102809205186;3712;33144;33158.502622460685;33168.50247246293;33237.00288991334;33240.667593324;5402.216678581623;5419.430959749248;5459.235707001023;5478.726063696839;5498.422665620093;199973;205386;205535;205709;205795;46487.53512464832;47427.28859067117;50110.248346274835;50184.74907625438;50323.74838125786;55618.44381556214;56305.71847140738;56476;56550.43449565534;56728.43271567314;17070.658586828195;17257.05086220245;17309.307627695;17326.826731732774;17346.82653173452;13985.510507132201;13986.370613322424;13991.16053036821;14050.648733781738;14075.71848563023;15348.616284592974;15413.5375938722;15450.5364839055;15513.301901414463;15556.766648500281;5893.116032595145;6080.300765411946;6090.269167699816;6111.51107911366;6222.533310001768;1105.7290963713942;1108.7394462301352;1109.073923274059;1109.6837401340579;1117.6032508459543;24384.26847194587;24724;24782.752172478406;25060.373490662514;25163.87418062898;1206.4751832952693;1210.642860356197;1216.4951545108859;1218.3542722357165;1220.0910321810309;13148.737025259441;13245;13291.933540332237;13294.401751921187;13321.600351989457;253956;255492;255599;256380;256473;56818;56988.14517782236;57088.71455642695;57189.42810571841;57247;1523.6114790728293;1528.4726769264364;1528.7936128622716;1535.4625880941805;1537.3619947721793;24512;24613.87693061523;24722.13472528453;24738.25785226446;24761.382610212146;40733;40919.181616366914;41031.58968410278;41064;41119.7944010278;231124;231213;231450;231823;232986.17534561772;35486.64513354937;35978.28043439064;36313;36315.45526817153;36331.818340908125;44746.55253447424;45459.772701137605;46160;46163;46342.30486542772;34229.828850855585;34418.139546511535;34623.13442163966;34656.306873862886;35254.64745352514;34328;34390.82804585961;34549.65450345565;34612.82693586516;35266.82366588253;40763.38854917238;40811.38782918318;40847;41102;41146.794266028475;32634.51048234326;32864.835675821465;32903.506447402826;33462.66537334595;33751.49372759362;25243.36891577652;25273;25349.493010140064;25835.095771647902;25907.22278331653 00:52:57 INFO - PID 24442 | |2;jquery.html;580.6342004537141;581.3808294166711;582.1645938078857;584.1208980484371;600.8317671052105;22930.312090637264;23828.5234295314;23914.04343826247;23994.88002559987;24023.399415014588;23005.769942300572;23880.283591492283;23906.163284285052;25164.49671006579;25631.23106306809;6583.9012414813815;6780.254172041072;6784.423324017464;6785.355391237825;6790.422814060811;6380.4257616814475;6518.57629254097;6631.237407698104;6660.700268487905;6685.097511835913;6582.835429114262;6604.636744979024;6610.8677826443445;6616.073749675049;6617.404433600975;6382.808515744512;6606.900896486556;6712.228093769181;6712.9664351678175;6714.83212919676;6245.62526248422;6255.6246625202175;6260.718267677966;6265.592736472115;6270.278917924452;29197.416051678847;29609.40781184364;29673;29790.85104574485;29851.402971940657;2199.9890000549894;2232.05137816429;2233.597952368573;2255.5827171973237;2256.4922892349255;19498.80501194984;20430.08064637095;20587.794122058738;20602.381928542167;20641.793582064136;2405.1822380390577;2506.3608779761043;2541.936451588725;2592.546304396723;2615.9215223543324;156520;160481;160599;160705;160948;15543;15679.216039197994;15749.346318636608;15800.92099539518;16084.919575402047;24571.3857153569;24592.262232133064;24627;24691.62962555563;24731.752682473303;10415.583376665;10503.894961050291;10668.093212076905;10811.78376432467;10925.617603384002;9993.450360230112;9998.900010999942;10059.195264378832;10113.887472378032;10145.64490242838;9515.524223788783;9517.809643807084;9682.951585242028;9712.22302215821;9939.453330066772;2772.6118343431936;2798.580212968071;2913.810602310843;2931.1939216715573;2990.8355040472984;1030.3817709374316;1050.9211809114195;1058.7300238439302;1061.5594528270835;1061.6443491430457;19901.402957911287;20559.58880822375;20945.685814712793;20967.161313547287;21116.04977776004;1099.0932480703452;1108.14672702019;1114.5820317380983;1122.7529943412437;1133.6444125388778;11266.94366528162;11659.76680466386;11679.007284380923;11731.824022639667;11784.052342465198;560365;576244;577842;582260;586266;124397;127961;128544;129430.35284823515;130608;1101.9779604407868;1155.8381826544291;1232.5131573028782;1256.3341429042623;1272.7709012377861;21566.568668626853;21651;21681.783182167976;21843.67234491452;21953.780462195173;58708.412915872;60188;61498.385016151056;62139.68930155501;63494.36505634885;79913;80063.59968200122;80375;80510.1948980526;80732.59633701794;14681.48614798477;14789.11265324084;14845;14890.851091488947;14953.476628318393;23739.287821364695;23957.16149934744;24053.398665033514;24159.637605436285;24385;19408.4177474676;19413;19451.416457506297;19517.12172952192;19725.605487889876;16975.320987160376;17304;17428.302867885144;17851.285948561912;18033.008184549977;19528.21887124499;19768.110435030172;19949.401517954484;20010;20312.796872031682;14732.337044833223;14796.334164962387;14857.405703771728;14879.25603719788;14955.40178392852;18856.434306970812;19037.14332854997;19093.71359429582;19480.512987175432;19646.214151434353 00:52:57 INFO - PID 24442 | |3;mootools.html;1237.8267042614034;1393.3312010235093;1394.4143459746906;1429.4568064135626;1429.8641629045237;15144.697106057885;15548.378064877392;15571.922140389297;15585.376584936588;15599.84400155998;14995.47515836946;15016;15066.773998390034;15189.4683686071;15290.770638440405;2819.732125448079;2859.8141120827186;2887.6101726266893;2915.489789286877;2917.6790553039255;2815;2817.506936286152;2832.0654184119294;2832.3910359272754;2833.9999999999895;2764.7097054809255;2853.2866783304175;2857.499812598392;2860.199144239616;2862.0984389917107;2835.376217232206;2860.127661063375;2871.1530098620956;2872.210142210898;2875.971240287591;2693.62289279501;2696.784257259434;2707.1472486166795;2735.179446166162;2801.523740964041;15926.601834954103;16089.839101608952;16099.03405795656;16112.75830862538;16112.838871611251;8285.751427457186;8591.871121933176;8597.441166324168;8608.52653104079;8618.913810861874;5729.512991395736;5810.302763668386;5933.732982015819;6042.12389203563;6107.7556897724035;2071.7099606055162;2088.895555222233;2096.2663067926105;2117.174302022197;2127.585120901425;28438.857805711046;28624.71375286241;28640.713592864013;28688.713112868812;28738;7053.68258428372;7090.680919358641;7115.89326160108;7270.309320614533;7283.397652516438;18936.337228196946;19070.523236919187;19120;19128.904355478135;19133.8086619132;8257.42198046143;8414.621342039623;8460.238578527962;8464;8465.746027619181;7612.885806712904;7623.275788800055;7832.37341012729;7835.960820195863;7846;5394.487523685244;5580.135079062752;5593.552515798727;5603.495685388253;5665.886682266414;1629.5030015845043;1645.0801665954314;1653.3634550698068;1659.4357918307833;1671.7879537335577;970.0784254957819;973.4645944730512;978.6525783346809;993.4635296939572;1001.0740065439439;8323.875141872755;8335.541545215072;8382.036065852504;8393.328533717287;8474.703385381483;751.2825251884437;772.1313522287427;784.9364111628774;786.3119770201074;798.9161138080534;5301.867453313621;5677;5993.520518358521;6020.217371741645;6025.246844144482;23113.19103831358;23353.299401017997;23807.880960595085;24116.63825042626;24529.877350613133;23940.88029559841;24089.63865542018;24212.515749684906;24216.152434664702;24376.87811560931;10801.405922674172;11940.641780746591;11943.820842687366;11950.402479875971;12047.33739644328;9365.85951210746;9368.859467108136;9404.153626173676;9415.576299066695;9455.290853185901;19781.901090494455;20155.09302081439;20291.188352466328;20304.79695203029;20524.794752052287;20411.79588204099;20721.378358649265;20772.584548309253;20816.27143049986;20900.686489702362;12113.75772484563;12304.446299916346;12307.138500304893;12316.507339706312;12334.876651233373;15017.174055427056;15062.246887655792;15115.168665723491;15299.388024478896;15343.769843452134;11651.825222621837;11680.007199387806;11687.18189726711;12137.817932731192;12221.57224497174;11749.588764393206;12127.151099422956;12143.514259429523;12274.693132671755;12288.262704237774;9831.262655300738;10111.696649100539;10116.89883101189;10117.08946194846;10124.493775311057;7712.884306735516;7750.922490775246;7823.178566250689;7893.723719669784;7897.723579674684;8014.679412823421;8128.918710813053;8146.83706325882;8190.221928916743;8273.420860539705 00:52:57 INFO - PID 24442 | |4;prototype.html;536.2090915899047;544.9100898351771;557.7573755416394;566.9886602267958;570.6433479075578;6287.968560157198;6294.779682711106;6329.715162817679;6384.776532821352;6411.294757576663;6182.814515564529;6198.132261483396;6221.7822376216845;6238.752249550085;6262.279837818653;5058.721770302632;5059.178695669556;5083.110455670261;5100.209467532539;5127.230915362707;5016.247562865581;5030.044291584605;5063.341765570471;5077.213031980031;5115.616328775338;4780.139574876521;5004.324416203821;5020.7740651670765;5031.245313203012;5043;4843.636727245453;4861.197902346109;4873.902521949577;4876.585490233334;4884.487128851455;4388.275934470808;4427.313766366218;4432.426488596566;4471.932921006188;4488.84289049885;5945.651467670246;5970.373110823344;6022.590963614589;6042.519582702266;6050.152978583002;5671.6880571568545;5723.885522289573;5748.540116790688;5784.334801497797;5788.768449262025;6510.772122975721;6521.804345869631;6523.380278873499;6570;6604.834879128012;4943.728094954776;4948.901021979576;4951.504849515056;4970.204767237261;4987.750612469362;6616.470682345401;6768.76309329176;6775.898361524581;6835.965820170917;6889.689963951584;5094;5098.617603679665;5128.743562821844;5151.5878729701535;5171.844844654666;5162.716050617252;5174.456682048331;5214.270002199695;5214.348206474191;5255.868603284948;5715.428457154251;5738.426157384228;5782.6819524925695;5788.5369170466265;5810.12848072784;6600.86798264032;6620.139381880421;6623.768168114189;6643.966780166068;6673.132492775908;1783.0728021428783;1786.5444311700433;1796.5059608607476;1801.8738688291694;1803.5761596024925;1202.7323260001606;1268.029957082814;1269.4668239339499;1281.0648226794492;1281.4938099450665;6105.145279660851;6145.938540614626;6166.136740856284;6166.383361663798;6205.2553693557065;6649.900251496231;6674.365935236242;6676;6704.229013663394;6741.359570840762;5917.822465326047;6089.208402907594;6131.233595800525;6167.660778657128;6167.6916154193;3441.741869359758;3458.844352004166;3476.3568739783223;3495.7378196635354;3528.241428092921;6612.404883560503;6694.263631000586;6697.22981857083;6771.695273712695;6859.039734437183;6681.231658359351;6734.528582999241;6757.229535890359;6783.287754785775;6783.932160678429;6683.43190828785;6767.1879374475375;6826.214985276757;6866.279040700754;6878.55289406187;6564.704588293443;6594.670266486753;6648.800535983928;6674.232463266787;6702.19573651165;6576.698155645486;6650.634215118215;6675.165604299463;6704.76533321351;6709.228438729609;6709.698063587052;6798.8640227196165;6826.726930922708;6834.726610935706;6856.731504671652;5081.364829396325;5107.514786095315;5112.082968886668;5134.383873935151;5158.432572417106;6485.24898277453;6573.80278591643;6578.309277525791;6592.340765923369;6713.429358504582;6339.2392912850755;6390.520710946605;6391.631029934877;6464.2889282177985;6471.385218404244;6355.904661430175;6361.554691171574;6379.425851673372;6400.39196276353;6474.287828338973;6265.56141070139;6291.842703932438;6297.496200303873;6317.357487053491;6378.585391949508;6385.106085148176;6479.352064793483;6489.1888513935755;6495.798277318711;6521.771737989147;6182.270563019204;6301.779437719658;6311.905321420274;6370.713317900613;6397.272736361063 00:52:57 INFO - PID 24442 | |5;yui.html;977.530785223093;985.19706439252;1006.3358183598822;1010.3180353261547;1018.775869308752;18156.18297176627;18186.727199092024;18872.716909246374;19215.519612009706;19220;17745.91127044363;17937.730934036;17969.460916172535;17980.190891409886;17996.55008624785;1041.9583216671342;1058.8147074262013;1059.7403636109163;1061.7451811565206;1062.2351906627216;1072.7264547540367;1073.5598404654093;1073.5866691323818;1074.2319241742152;1075.6127793994156;1080.9027187553118;1126.3804907300992;1130.4630300607187;1131.9377434241114;1134.2683968840092;1116.3246236027169;1130.3952385473815;1131.3890499130541;1133.8696049954237;1133.8979491845732;795.852767238057;810.9918900811034;813.5484805932705;817.9263866252065;823.279630323467;20529.178832846817;20535.794642053537;20595.382138535868;20661.276855309992;20661.8966905166;22887.885560572257;22979.310620681405;23019.424514387276;23108.884455577616;23122.65316020261;17681.292748290052;17766.11169441536;18085;18116.818831811644;18158.45524634263;3969.7816620085882;3988.880333589997;3994.800259986989;3994.840206391741;3997.8400863965408;127466;150676.2466187662;152606;153918;156953.99999999886;18033.008184549977;18216.36242731498;18261.086945652663;18347;18690.71963920542;32899.67100328966;33971.49042764361;34069;34142;34157.14607134841;9134.314926380548;9153;9225.12361325673;9227.215686666708;9236;4512.842050528216;4575.062112266977;4609.1703493371515;4616.238320677118;4625.190591646516;5813.6221145625395;6030.246219222598;6066.878662426815;6099.451049405486;6103.115048317969;1171.1041053594008;1180.1974657233163;1186.6736647422028;1224.8285240066398;1225.154643296123;720.0747040053611;741.8553382090548;743.2196193996282;743.5761615879005;761.482192109371;12523.311217883103;12626.873731262753;12927.418266178045;12948.611541653765;13192.894136213981;743.2641684732184;743.434989408043;744.1702501710662;750.1335956969709;757.9734709285149;5565.332160140728;5590.161475778666;5645.23789288449;5652.547796176296;5658.207850900877;146352;146771;147209;148245;150893.24553377382;127857.36071319584;129780;131825.34087329693;134343;134671;113538.43230783794;115006;116087;116917.41541292239;117579.41210293894;10679.51942162589;10932.508037138507;10973.067289280501;11028.503717332578;11165.16261280391;47021.76489117533;47814.760926195144;47856.282155766996;48235.5176448231;48653;62299.688501557204;62576;62672.68663656653;64224;65656.67171664111;17495.30018799234;17665.470035898943;17745.733813993058;17774.46676599704;17798.822011780234;18109.456716298533;18113;18174.27302907869;18255.087245637398;18287.085645717925;17752.822471775635;18157.727634085764;18178.45464636063;18226.72659910129;18403.355882544045;17332.480025599252;17436.47690569285;17538.82461175372;17697.20362583661;17827.554311142325;18035.729464058313;18036.188371523574;18166.5458363542;18192.636147276717;18275.908620456812;12893.35533223354;13021.153625014344;13064.673383165496;13354.799678005033;13438.46246150143;13029.869701302865;13039.608811735663;13328.1391248755;13391.263480508665;13520.797188042385 00:52:57 INFO - PID 24442 | __end_tp_report 00:52:57 INFO - PID 24442 | __start_cc_report 00:52:57 INFO - PID 24442 | _x_x_mozilla_cycle_collect,355 00:52:57 INFO - PID 24442 | __end_cc_report 00:52:57 INFO - PID 24442 | __startTimestamp1505375577077__endTimestamp 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | ------- Summary: start ------- 00:52:57 INFO - PID 24442 | Number of tests: 6 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#0] dojo.html Cycles:165 Average:6188.00 Median:6448.94 stddev:720.64 (11.2%) stddev-sans-first:698.08 00:52:57 INFO - PID 24442 | Values: 3800.0 3816.7 3819.9 3825.5 3841.7 6071.6 6153.0 6221.5 6245.4 6267.6 6038.9 6161.7 6217.0 6237.1 6239.8 5430.6 5501.8 5602.7 5613.8 5624.7 5580.3 5617.8 5622.2 5647.1 5692.0 5320.8 5509.9 5577.4 5596.3 5712.0 5501.3 5507.8 5541.7 5601.9 5602.5 5542.1 5594.9 5597.1 5597.8 5608.2 6114.2 6154.6 6166.3 6251.2 6253.8 6675.4 6675.7 6777.9 6799.5 6805.4 6757.6 6766.9 6841.9 6855.7 6873.6 6186.1 6269.4 6286.1 6292.0 6387.5 6897.8 6902.2 6904.1 6907.5 6913.0 6524.4 6544.3 6629.6 6632.2 6668.3 6716.7 6763.0 6766.1 6831.0 6838.4 6678.8 6698.2 6777.3 6784.1 6787.0 6610.0 6688.3 6714.2 6717.6 6808.5 4927.0 4931.5 4936.8 4970.4 4991.3 4579.2 4591.2 4618.3 4622.1 4628.9 6237.2 6241.8 6242.1 6317.7 6336.5 6642.9 6690.6 6707.9 6742.4 6785.3 6178.1 6184.8 6203.3 6203.7 6206.0 5298.4 5432.2 5438.1 5441.6 5442.7 6842.8 6842.8 6894.7 6963.1 6971.9 6594.4 6681.4 6696.8 6697.2 6744.5 6856.0 6866.6 6924.7 6948.4 6960.8 6603.8 6614.2 6614.8 6684.0 6704.8 6631.7 6665.2 6669.1 6765.5 6772.9 6496.9 6512.8 6513.6 6515.0 6521.1 6425.1 6448.9 6491.9 6504.3 6508.8 6419.9 6500.1 6511.5 6511.8 6521.3 6493.9 6527.5 6559.2 6622.9 6647.9 6243.9 6273.5 6318.0 6335.6 6417.6 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#1] ext.html Cycles:180 Average:40958.94 Median:3684.61 stddev:60051.68 (1629.8%) stddev-sans-first:60145.01 00:52:57 INFO - PID 24442 | Values: 952.6 974.2 979.2 979.6 982.0 40117.2 43781.8 44076.6 44148.8 44194.6 42753.0 42780.4 42820.1 42852.1 43100.6 7378.2 7455.9 7973.3 8125.8 8157.0 7999.1 8056.6 8056.9 8057.2 8064.6 8043.1 8113.7 8138.1 8144.1 8146.3 8081.9 8085.9 8087.7 8092.0 8116.0 7985.6 8027.5 8033.5 8037.1 8039.2 39596.0 39739.0 39841.2 39891.4 39891.6 3662.5 3706.7 3711.5 3711.6 3712.0 33144.0 33158.5 33168.5 33237.0 33240.7 5402.2 5419.4 5459.2 5478.7 5498.4 199973.0 205386.0 205535.0 205709.0 205795.0 46487.5 47427.3 50110.2 50184.7 50323.7 55618.4 56305.7 56476.0 56550.4 56728.4 17070.7 17257.1 17309.3 17326.8 17346.8 13985.5 13986.4 13991.2 14050.6 14075.7 15348.6 15413.5 15450.5 15513.3 15556.8 5893.1 6080.3 6090.3 6111.5 6222.5 1105.7 1108.7 1109.1 1109.7 1117.6 24384.3 24724.0 24782.8 25060.4 25163.9 1206.5 1210.6 1216.5 1218.4 1220.1 13148.7 13245.0 13291.9 13294.4 13321.6 253956.0 255492.0 255599.0 256380.0 256473.0 56818.0 56988.1 57088.7 57189.4 57247.0 1523.6 1528.5 1528.8 1535.5 1537.4 24512.0 24613.9 24722.1 24738.3 24761.4 40733.0 40919.2 41031.6 41064.0 41119.8 231124.0 231213.0 231450.0 231823.0 232986.2 35486.6 35978.3 36313.0 36315.5 36331.8 44746.6 45459.8 46160.0 46163.0 46342.3 34229.8 34418.1 34623.1 34656.3 35254.6 34328.0 34390.8 34549.7 34612.8 35266.8 40763.4 40811.4 40847.0 41102.0 41146.8 32634.5 32864.8 32903.5 33462.7 33751.5 25243.4 25273.0 25349.5 25835.1 25907.2 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#2] jquery.html Cycles:180 Average:38982.78 Median:2244.59 stddev:97078.22 (4325.0%) stddev-sans-first:97307.73 00:52:57 INFO - PID 24442 | Values: 580.6 581.4 582.2 584.1 600.8 22930.3 23828.5 23914.0 23994.9 24023.4 23005.8 23880.3 23906.2 25164.5 25631.2 6583.9 6780.3 6784.4 6785.4 6790.4 6380.4 6518.6 6631.2 6660.7 6685.1 6582.8 6604.6 6610.9 6616.1 6617.4 6382.8 6606.9 6712.2 6713.0 6714.8 6245.6 6255.6 6260.7 6265.6 6270.3 29197.4 29609.4 29673.0 29790.9 29851.4 2200.0 2232.1 2233.6 2255.6 2256.5 19498.8 20430.1 20587.8 20602.4 20641.8 2405.2 2506.4 2541.9 2592.5 2615.9 156520.0 160481.0 160599.0 160705.0 160948.0 15543.0 15679.2 15749.3 15800.9 16084.9 24571.4 24592.3 24627.0 24691.6 24731.8 10415.6 10503.9 10668.1 10811.8 10925.6 9993.5 9998.9 10059.2 10113.9 10145.6 9515.5 9517.8 9683.0 9712.2 9939.5 2772.6 2798.6 2913.8 2931.2 2990.8 1030.4 1050.9 1058.7 1061.6 1061.6 19901.4 20559.6 20945.7 20967.2 21116.0 1099.1 1108.1 1114.6 1122.8 1133.6 11266.9 11659.8 11679.0 11731.8 11784.1 560365.0 576244.0 577842.0 582260.0 586266.0 124397.0 127961.0 128544.0 129430.4 130608.0 1102.0 1155.8 1232.5 1256.3 1272.8 21566.6 21651.0 21681.8 21843.7 21953.8 58708.4 60188.0 61498.4 62139.7 63494.4 79913.0 80063.6 80375.0 80510.2 80732.6 14681.5 14789.1 14845.0 14890.9 14953.5 23739.3 23957.2 24053.4 24159.6 24385.0 19408.4 19413.0 19451.4 19517.1 19725.6 16975.3 17304.0 17428.3 17851.3 18033.0 19528.2 19768.1 19949.4 20010.0 20312.8 14732.3 14796.3 14857.4 14879.3 14955.4 18856.4 19037.1 19093.7 19480.5 19646.2 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#3] mootools.html Cycles:180 Average:10012.01 Median:2808.26 stddev:7264.27 (258.7%) stddev-sans-first:7254.73 00:52:57 INFO - PID 24442 | Values: 1237.8 1393.3 1394.4 1429.5 1429.9 15144.7 15548.4 15571.9 15585.4 15599.8 14995.5 15016.0 15066.8 15189.5 15290.8 2819.7 2859.8 2887.6 2915.5 2917.7 2815.0 2817.5 2832.1 2832.4 2834.0 2764.7 2853.3 2857.5 2860.2 2862.1 2835.4 2860.1 2871.2 2872.2 2876.0 2693.6 2696.8 2707.1 2735.2 2801.5 15926.6 16089.8 16099.0 16112.8 16112.8 8285.8 8591.9 8597.4 8608.5 8618.9 5729.5 5810.3 5933.7 6042.1 6107.8 2071.7 2088.9 2096.3 2117.2 2127.6 28438.9 28624.7 28640.7 28688.7 28738.0 7053.7 7090.7 7115.9 7270.3 7283.4 18936.3 19070.5 19120.0 19128.9 19133.8 8257.4 8414.6 8460.2 8464.0 8465.7 7612.9 7623.3 7832.4 7836.0 7846.0 5394.5 5580.1 5593.6 5603.5 5665.9 1629.5 1645.1 1653.4 1659.4 1671.8 970.1 973.5 978.7 993.5 1001.1 8323.9 8335.5 8382.0 8393.3 8474.7 751.3 772.1 784.9 786.3 798.9 5301.9 5677.0 5993.5 6020.2 6025.2 23113.2 23353.3 23807.9 24116.6 24529.9 23940.9 24089.6 24212.5 24216.2 24376.9 10801.4 11940.6 11943.8 11950.4 12047.3 9365.9 9368.9 9404.2 9415.6 9455.3 19781.9 20155.1 20291.2 20304.8 20524.8 20411.8 20721.4 20772.6 20816.3 20900.7 12113.8 12304.4 12307.1 12316.5 12334.9 15017.2 15062.2 15115.2 15299.4 15343.8 11651.8 11680.0 11687.2 12137.8 12221.6 11749.6 12127.2 12143.5 12274.7 12288.3 9831.3 10111.7 10116.9 10117.1 10124.5 7712.9 7750.9 7823.2 7893.7 7897.7 8014.7 8128.9 8146.8 8190.2 8273.4 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#4] prototype.html Cycles:180 Average:5549.66 Median:6190.47 stddev:1541.53 (24.9%) stddev-sans-first:1499.23 00:52:57 INFO - PID 24442 | Values: 536.2 544.9 557.8 567.0 570.6 6288.0 6294.8 6329.7 6384.8 6411.3 6182.8 6198.1 6221.8 6238.8 6262.3 5058.7 5059.2 5083.1 5100.2 5127.2 5016.2 5030.0 5063.3 5077.2 5115.6 4780.1 5004.3 5020.8 5031.2 5043.0 4843.6 4861.2 4873.9 4876.6 4884.5 4388.3 4427.3 4432.4 4471.9 4488.8 5945.7 5970.4 6022.6 6042.5 6050.2 5671.7 5723.9 5748.5 5784.3 5788.8 6510.8 6521.8 6523.4 6570.0 6604.8 4943.7 4948.9 4951.5 4970.2 4987.8 6616.5 6768.8 6775.9 6836.0 6889.7 5094.0 5098.6 5128.7 5151.6 5171.8 5162.7 5174.5 5214.3 5214.3 5255.9 5715.4 5738.4 5782.7 5788.5 5810.1 6600.9 6620.1 6623.8 6644.0 6673.1 1783.1 1786.5 1796.5 1801.9 1803.6 1202.7 1268.0 1269.5 1281.1 1281.5 6105.1 6145.9 6166.1 6166.4 6205.3 6649.9 6674.4 6676.0 6704.2 6741.4 5917.8 6089.2 6131.2 6167.7 6167.7 3441.7 3458.8 3476.4 3495.7 3528.2 6612.4 6694.3 6697.2 6771.7 6859.0 6681.2 6734.5 6757.2 6783.3 6783.9 6683.4 6767.2 6826.2 6866.3 6878.6 6564.7 6594.7 6648.8 6674.2 6702.2 6576.7 6650.6 6675.2 6704.8 6709.2 6709.7 6798.9 6826.7 6834.7 6856.7 5081.4 5107.5 5112.1 5134.4 5158.4 6485.2 6573.8 6578.3 6592.3 6713.4 6339.2 6390.5 6391.6 6464.3 6471.4 6355.9 6361.6 6379.4 6400.4 6474.3 6265.6 6291.8 6297.5 6317.4 6378.6 6385.1 6479.4 6489.2 6495.8 6521.8 6182.3 6301.8 6311.9 6370.7 6397.3 00:52:57 INFO - PID 24442 | 00:52:57 INFO - PID 24442 | [#5] yui.html Cycles:180 Average:27327.37 Median:18111.23 stddev:40964.11 (226.2%) stddev-sans-first:41031.24 00:52:57 INFO - PID 24442 | Values: 977.5 985.2 1006.3 1010.3 1018.8 18156.2 18186.7 18872.7 19215.5 19220.0 17745.9 17937.7 17969.5 17980.2 17996.6 1042.0 1058.8 1059.7 1061.7 1062.2 1072.7 1073.6 1073.6 1074.2 1075.6 1080.9 1126.4 1130.5 1131.9 1134.3 1116.3 1130.4 1131.4 1133.9 1133.9 795.9 811.0 813.5 817.9 823.3 20529.2 20535.8 20595.4 20661.3 20661.9 22887.9 22979.3 23019.4 23108.9 23122.7 17681.3 17766.1 18085.0 18116.8 18158.5 3969.8 3988.9 3994.8 3994.8 3997.8 127466.0 150676.2 152606.0 153918.0 156954.0 18033.0 18216.4 18261.1 18347.0 18690.7 32899.7 33971.5 34069.0 34142.0 34157.1 9134.3 9153.0 9225.1 9227.2 9236.0 4512.8 4575.1 4609.2 4616.2 4625.2 5813.6 6030.2 6066.9 6099.5 6103.1 1171.1 1180.2 1186.7 1224.8 1225.2 720.1 741.9 743.2 743.6 761.5 12523.3 12626.9 12927.4 12948.6 13192.9 743.3 743.4 744.2 750.1 758.0 5565.3 5590.2 5645.2 5652.5 5658.2 146352.0 146771.0 147209.0 148245.0 150893.2 127857.4 129780.0 131825.3 134343.0 134671.0 113538.4 115006.0 116087.0 116917.4 117579.4 10679.5 10932.5 10973.1 11028.5 11165.2 47021.8 47814.8 47856.3 48235.5 48653.0 62299.7 62576.0 62672.7 64224.0 65656.7 17495.3 17665.5 17745.7 17774.5 17798.8 18109.5 18113.0 18174.3 18255.1 18287.1 17752.8 18157.7 18178.5 18226.7 18403.4 17332.5 17436.5 17538.8 17697.2 17827.6 18035.7 18036.2 18166.5 18192.6 18275.9 12893.4 13021.2 13064.7 13354.8 13438.5 13029.9 13039.6 13328.1 13391.3 13520.8 00:52:57 INFO - PID 24442 | -------- Summary: end -------- 00:52:57 INFO - PID 24442 | 00:52:57 INFO - TEST-INFO | 24442: exit 0 00:52:57 INFO - TEST-OK | dromaeo_css | took 1108463ms 00:52:57 INFO - TEST-START | kraken 00:52:57 INFO - Initialising browser for kraken test... 00:52:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59880/getInfo.html -profile /tmp/tmppCZDdu/profile 00:52:57 INFO - TEST-INFO | started process 24821 (/builds/slave/test/build/application/firefox/firefox http://localhost:59880/getInfo.html) 00:53:02 INFO - TEST-INFO | 24821: exit 0 00:53:02 INFO - Browser initialized. 00:53:02 INFO - Running cycle 1/1 for kraken test... 00:53:02 INFO - Using env: {'DISPLAY': ':0', 00:53:02 INFO - 'HOME': '/home/cltbld', 00:53:02 INFO - 'JSGC_DISABLE_POISONING': '1', 00:53:02 INFO - 'LANG': 'en_US.UTF-8', 00:53:02 INFO - 'LANGUAGE': 'en_US:en', 00:53:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:53:02 INFO - 'LOGNAME': 'cltbld', 00:53:02 INFO - 'MAIL': '/var/mail/cltbld', 00:53:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:53:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:53:02 INFO - 'MOZ_CRASHREPORTER': '1', 00:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:53:02 INFO - 'MOZ_NO_REMOTE': '1', 00:53:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:02 INFO - 'NO_EM_RESTART': '1', 00:53:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:02 INFO - 'PWD': '/builds/slave/test', 00:53:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:53:02 INFO - 'RUST_BACKTRACE': 'full', 00:53:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:53:02 INFO - 'SHELL': '/bin/bash', 00:53:02 INFO - 'SHLVL': '1', 00:53:02 INFO - 'TERM': 'linux', 00:53:02 INFO - 'TMOUT': '86400', 00:53:02 INFO - 'USER': 'cltbld', 00:53:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636', 00:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:02 INFO - '_': '/tools/buildbot/bin/python'} 00:53:02 INFO - TEST-INFO | started process 25055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCZDdu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:53:03 INFO - PID 25055 | 00:53:03 INFO - PID 25055 | (/builds/slave/test/build/application/firefox/firefox:25105): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:53:03 INFO - PID 25055 | 00:53:14 INFO - PID 25055 | RSS: Main: 165826560 00:53:14 INFO - PID 25055 | 00:53:16 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59880/tests/kraken/driver.html?testName=audio-beat-detection) 00:53:17 INFO - PID 25055 | RSS: Main: 171089920 00:53:17 INFO - PID 25055 | 00:53:20 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59880/tests/kraken/driver.html?testName=audio-dft) 00:53:20 INFO - PID 25055 | RSS: Main: 171642880 00:53:20 INFO - PID 25055 | 00:53:23 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59880/tests/kraken/driver.html?testName=audio-fft) 00:53:24 INFO - PID 25055 | RSS: Main: 167108608 00:53:24 INFO - PID 25055 | 00:53:26 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59880/tests/kraken/driver.html?testName=audio-oscillator) 00:53:27 INFO - PID 25055 | RSS: Main: 168407040 00:53:27 INFO - PID 25055 | 00:53:29 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:53:29 INFO - PID 25055 | RSS: Main: 168153088 00:53:29 INFO - PID 25055 | 00:53:32 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59880/tests/kraken/driver.html?testName=imaging-darkroom) 00:53:33 INFO - PID 25055 | RSS: Main: 171782144 00:53:33 INFO - PID 25055 | 00:53:37 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59880/tests/kraken/driver.html?testName=imaging-desaturate) 00:53:37 INFO - PID 25055 | RSS: Main: 171003904 00:53:37 INFO - PID 25055 | 00:53:40 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59880/tests/kraken/driver.html?testName=json-parse-financial) 00:53:41 INFO - PID 25055 | RSS: Main: 170561536 00:53:41 INFO - PID 25055 | 00:53:42 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:53:43 INFO - PID 25055 | RSS: Main: 170885120 00:53:43 INFO - PID 25055 | 00:53:44 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:53:45 INFO - PID 25055 | RSS: Main: 170614784 00:53:45 INFO - PID 25055 | 00:53:47 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:53:48 INFO - PID 25055 | RSS: Main: 167809024 00:53:48 INFO - PID 25055 | 00:53:50 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:53:51 INFO - PID 25055 | RSS: Main: 168181760 00:53:51 INFO - PID 25055 | 00:53:54 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:53:54 INFO - PID 25055 | RSS: Main: 168644608 00:53:54 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | Cycle 1(1): loaded http://localhost:59880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59880/tests/kraken/driver.html?testName=ai-astar) 00:53:56 INFO - PID 25055 | RSS: Main: 170311680 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | __start_tp_report 00:53:56 INFO - PID 25055 | _x_x_mozilla_page_load 00:53:56 INFO - PID 25055 | _x_x_mozilla_page_load_details 00:53:56 INFO - PID 25055 | |i|pagename|runs| 00:53:56 INFO - PID 25055 | |0;ai-astar;105;105;105;106;106;106;108;105;105;106 00:53:56 INFO - PID 25055 | |1;audio-beat-detection;112;118;114;113;115;112;116;113;117;146 00:53:56 INFO - PID 25055 | |2;audio-dft;166;164;162;163;160;163;162;163;166;166 00:53:56 INFO - PID 25055 | |3;audio-fft;74;74;73;74;74;74;74;74;74;75 00:53:56 INFO - PID 25055 | |4;audio-oscillator;79;78;79;79;76;77;77;78;77;77 00:53:56 INFO - PID 25055 | |5;imaging-gaussian-blur;114;114;114;115;113;115;118;114;115;114 00:53:56 INFO - PID 25055 | |6;imaging-darkroom;149;153;149;157;151;150;151;150;151;150 00:53:56 INFO - PID 25055 | |7;imaging-desaturate;93;94;94;94;94;94;94;93;94;94 00:53:56 INFO - PID 25055 | |8;json-parse-financial;46;47;46;44;45;45;46;46;44;44 00:53:56 INFO - PID 25055 | |9;json-stringify-tinderbox;36;37;37;36;37;37;37;37;37;36 00:53:56 INFO - PID 25055 | |10;stanford-crypto-aes;76;72;75;71;73;71;72;81;73;77 00:53:56 INFO - PID 25055 | |11;stanford-crypto-ccm;108;106;108;111;108;110;121;107;110;110 00:53:56 INFO - PID 25055 | |12;stanford-crypto-pbkdf2;155;154;152;159;163;154;159;157;155;152 00:53:56 INFO - PID 25055 | |13;stanford-crypto-sha256-iterative;62;61;58;60;60;60;61;60;60;61 00:53:56 INFO - PID 25055 | __end_tp_report 00:53:56 INFO - PID 25055 | __start_cc_report 00:53:56 INFO - PID 25055 | _x_x_mozilla_cycle_collect,942 00:53:56 INFO - PID 25055 | __end_cc_report 00:53:56 INFO - PID 25055 | __startTimestamp1505375636633__endTimestamp 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | ------- Summary: start ------- 00:53:56 INFO - PID 25055 | Number of tests: 14 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.00 stddev:0.95 (0.9%) stddev-sans-first:0.97 00:53:56 INFO - PID 25055 | Values: 105.0 105.0 105.0 106.0 106.0 106.0 108.0 105.0 105.0 106.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:115.50 stddev:10.19 (8.8%) stddev-sans-first:10.60 00:53:56 INFO - PID 25055 | Values: 112.0 118.0 114.0 113.0 115.0 112.0 116.0 113.0 117.0 146.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:1.92 00:53:56 INFO - PID 25055 | Values: 166.0 164.0 162.0 163.0 160.0 163.0 162.0 163.0 166.0 166.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 00:53:56 INFO - PID 25055 | Values: 74.0 74.0 73.0 74.0 74.0 74.0 74.0 74.0 74.0 75.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:1.06 (1.4%) stddev-sans-first:1.01 00:53:56 INFO - PID 25055 | Values: 79.0 78.0 79.0 79.0 76.0 77.0 77.0 78.0 77.0 77.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.41 00:53:56 INFO - PID 25055 | Values: 114.0 114.0 114.0 115.0 113.0 115.0 118.0 114.0 115.0 114.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:2.38 (1.6%) stddev-sans-first:2.40 00:53:56 INFO - PID 25055 | Values: 149.0 153.0 149.0 157.0 151.0 150.0 151.0 150.0 151.0 150.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 00:53:56 INFO - PID 25055 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:46.00 stddev:1.06 (2.3%) stddev-sans-first:1.09 00:53:56 INFO - PID 25055 | Values: 46.0 47.0 46.0 44.0 45.0 45.0 46.0 46.0 44.0 44.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#9] json-stringify-tinderbox Cycles:10 Average:36.70 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 00:53:56 INFO - PID 25055 | Values: 36.0 37.0 37.0 36.0 37.0 37.0 37.0 37.0 37.0 36.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:3.18 (4.3%) stddev-sans-first:3.30 00:53:56 INFO - PID 25055 | Values: 76.0 72.0 75.0 71.0 73.0 71.0 72.0 81.0 73.0 77.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#11] stanford-crypto-ccm Cycles:10 Average:109.90 Median:110.00 stddev:4.20 (3.8%) stddev-sans-first:4.40 00:53:56 INFO - PID 25055 | Values: 108.0 106.0 108.0 111.0 108.0 110.0 121.0 107.0 110.0 110.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.00 stddev:3.50 (2.2%) stddev-sans-first:3.69 00:53:56 INFO - PID 25055 | Values: 155.0 154.0 152.0 159.0 163.0 154.0 159.0 157.0 155.0 152.0 00:53:56 INFO - PID 25055 | 00:53:56 INFO - PID 25055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:1.06 (1.8%) stddev-sans-first:0.93 00:53:56 INFO - PID 25055 | Values: 62.0 61.0 58.0 60.0 60.0 60.0 61.0 60.0 60.0 61.0 00:53:56 INFO - PID 25055 | -------- Summary: end -------- 00:53:56 INFO - PID 25055 | 00:53:57 INFO - PID 25055 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:53:57 INFO - TEST-INFO | 25055: exit 0 00:53:57 INFO - TEST-OK | kraken | took 59712ms 00:53:57 INFO - SUITE-END | took 1168s 00:53:57 INFO - Completed test suite (00:19:28) 00:53:57 INFO - javascript benchmark 00:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8915.304270456827, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3799.981000095, 3816.675582575481, 3819.866304679336, 3825.4835597194406, 3841.6926645868334, 6071.60534565253, 6153.0, 6221.502279817615, 6245.437910588046, 6267.561270711047, 6038.87922241556, 6161.722722477488, 6216.968915155429, 6237.095621134944, 6239.844003899905, 5430.619856610019, 5501.807436739715, 5602.663840169583, 5613.80351687691, 5624.746886390102, 5580.330360356763, 5617.8033768818095, 5622.184783206453, 5647.068233741427, 5691.971540142294, 5320.76056577455, 5509.862253443656, 5577.386487486373, 5596.328440587135, 5712.028955077647, 5501.257330260403, 5507.779688812443, 5541.695206763627, 5601.915971260434, 5602.523785478239, 5542.11326187812, 5594.944050559483, 5597.132444471114, 5597.776088956437, 5608.2428872102155, 6114.1745864308195, 6154.569180157391, 6166.290876549209, 6251.187345645037, 6253.843653908643, 6675.432588230006, 6675.666216689195, 6777.93222067778, 6799.4900382471515, 6805.353491418307, 6757.594544327356, 6766.864662706767, 6841.897371539431, 6855.725770969155, 6873.5875847448815, 6186.133941248228, 6269.3730626937395, 6286.057091436275, 6292.0, 6387.457066149383, 6897.827554311182, 6902.240753517109, 6904.067950826574, 6907.481938854606, 6913.0, 6524.380183882524, 6544.312847150981, 6629.602223866487, 6632.1709786276715, 6668.33316668339, 6716.697748601325, 6763.0193621924545, 6766.120404347404, 6831.04365388846, 6838.384545390939, 6678.83302917431, 6698.162729658793, 6777.288384719632, 6784.0841486399695, 6787.0, 6610.0, 6688.33116688337, 6714.194296684429, 6717.630530320879, 6808.455323574102, 4927.039227350704, 4931.457539670633, 4936.802527898843, 4970.403551573834, 4991.326170966946, 4579.152856721517, 4591.196540605448, 4618.307253911873, 4622.075584883037, 4628.861134165981, 6237.220347456568, 6241.843953901189, 6242.063690446469, 6317.715702793385, 6336.461400780985, 6642.867142657216, 6690.565113267622, 6707.865842683119, 6742.393184613408, 6785.2536221016635, 6178.135061091451, 6184.783532576428, 6203.2556093269095, 6203.689815509207, 6206.0, 5298.417174110845, 5432.212329212242, 5438.129899216106, 5441.59188060897, 5442.727863606804, 6842.7605033823575, 6842.794716158523, 6894.724211031503, 6963.1296087989, 6971.895421568681, 6594.373534514213, 6681.398674119353, 6696.799096027127, 6697.229818570927, 6744.527883048139, 6856.040154378491, 6866.588004719732, 6924.723011079501, 6948.444124469929, 6960.79117626472, 6603.80188594343, 6614.206295244601, 6614.801555953329, 6683.997400389981, 6704.83237919056, 6631.734730610721, 6665.200175978914, 6669.066330713801, 6765.526413151032, 6772.864542709217, 6496.935030649822, 6512.837179070561, 6513.641749703812, 6514.990176522647, 6521.087047813215, 6425.132607097982, 6448.935510644834, 6491.902621460777, 6504.317046710216, 6508.837279067871, 6419.903701444576, 6500.057491663777, 6511.544191906521, 6511.837204069936, 6521.315261897622, 6493.8701225976165, 6527.51043671717, 6559.212894452697, 6622.867542649216, 6647.867042659216, 6243.906341404973, 6273.498120150468, 6318.0, 6335.619862808247, 6417.582857114273], "value": 6140.091185573137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.5665822050968, 974.1914211204701, 979.2166266986409, 979.6375341123785, 981.9852702209466, 40117.1976560469, 43781.78109109454, 44076.55923440764, 44148.77925610368, 44194.558054419445, 42753.0, 42780.35829462561, 42820.14359712804, 42852.14295714084, 43100.568994310044, 7378.225286344937, 7455.925440745577, 7973.282404583586, 8125.75622731319, 8157.0, 7999.080105787822, 8056.637451314676, 8056.879146812803, 8057.1539988301265, 8064.556449395281, 8043.075046369655, 8113.675452981903, 8138.064122625885, 8144.1448647892, 8146.26683598476, 8081.878771818428, 8085.919140808604, 8087.676492940275, 8091.959540202321, 8115.95942020292, 7985.640646170878, 8027.478213916135, 8033.477823941425, 8037.115917249098, 8039.155888631726, 39596.0, 39739.00652483682, 39841.203175936316, 39891.40162897559, 39891.60108398908, 3662.5238718966366, 3706.703463722896, 3711.480392745018, 3711.6102809205186, 3712.0, 33144.0, 33158.502622460685, 33168.50247246293, 33237.00288991334, 33240.667593324, 5402.216678581623, 5419.430959749248, 5459.235707001023, 5478.726063696839, 5498.422665620093, 199973.0, 205386.0, 205535.0, 205709.0, 205795.0, 46487.53512464832, 47427.28859067117, 50110.248346274835, 50184.74907625438, 50323.74838125786, 55618.44381556214, 56305.71847140738, 56476.0, 56550.43449565534, 56728.43271567314, 17070.658586828195, 17257.05086220245, 17309.307627695, 17326.826731732774, 17346.82653173452, 13985.510507132201, 13986.370613322424, 13991.16053036821, 14050.648733781738, 14075.71848563023, 15348.616284592974, 15413.5375938722, 15450.5364839055, 15513.301901414463, 15556.766648500281, 5893.116032595145, 6080.300765411946, 6090.269167699816, 6111.51107911366, 6222.533310001768, 1105.7290963713942, 1108.7394462301352, 1109.073923274059, 1109.6837401340579, 1117.6032508459543, 24384.26847194587, 24724.0, 24782.752172478406, 25060.373490662514, 25163.87418062898, 1206.4751832952693, 1210.642860356197, 1216.4951545108859, 1218.3542722357165, 1220.0910321810309, 13148.737025259441, 13245.0, 13291.933540332237, 13294.401751921187, 13321.600351989457, 253956.0, 255492.0, 255599.0, 256380.0, 256473.0, 56818.0, 56988.14517782236, 57088.71455642695, 57189.42810571841, 57247.0, 1523.6114790728293, 1528.4726769264364, 1528.7936128622716, 1535.4625880941805, 1537.3619947721793, 24512.0, 24613.87693061523, 24722.13472528453, 24738.25785226446, 24761.382610212146, 40733.0, 40919.181616366914, 41031.58968410278, 41064.0, 41119.7944010278, 231124.0, 231213.0, 231450.0, 231823.0, 232986.17534561772, 35486.64513354937, 35978.28043439064, 36313.0, 36315.45526817153, 36331.818340908125, 44746.55253447424, 45459.772701137605, 46160.0, 46163.0, 46342.30486542772, 34229.828850855585, 34418.139546511535, 34623.13442163966, 34656.306873862886, 35254.64745352514, 34328.0, 34390.82804585961, 34549.65450345565, 34612.82693586516, 35266.82366588253, 40763.38854917238, 40811.38782918318, 40847.0, 41102.0, 41146.794266028475, 32634.51048234326, 32864.835675821465, 32903.506447402826, 33462.66537334595, 33751.49372759362, 25243.36891577652, 25273.0, 25349.493010140064, 25835.095771647902, 25907.22278331653], "value": 18376.553300570864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6342004537141, 581.3808294166711, 582.1645938078857, 584.1208980484371, 600.8317671052105, 22930.312090637264, 23828.5234295314, 23914.04343826247, 23994.88002559987, 24023.399415014588, 23005.769942300572, 23880.283591492283, 23906.163284285052, 25164.49671006579, 25631.23106306809, 6583.9012414813815, 6780.254172041072, 6784.423324017464, 6785.355391237825, 6790.422814060811, 6380.4257616814475, 6518.57629254097, 6631.237407698104, 6660.700268487905, 6685.097511835913, 6582.835429114262, 6604.636744979024, 6610.8677826443445, 6616.073749675049, 6617.404433600975, 6382.808515744512, 6606.900896486556, 6712.228093769181, 6712.9664351678175, 6714.83212919676, 6245.62526248422, 6255.6246625202175, 6260.718267677966, 6265.592736472115, 6270.278917924452, 29197.416051678847, 29609.40781184364, 29673.0, 29790.85104574485, 29851.402971940657, 2199.9890000549894, 2232.05137816429, 2233.597952368573, 2255.5827171973237, 2256.4922892349255, 19498.80501194984, 20430.08064637095, 20587.794122058738, 20602.381928542167, 20641.793582064136, 2405.1822380390577, 2506.3608779761043, 2541.936451588725, 2592.546304396723, 2615.9215223543324, 156520.0, 160481.0, 160599.0, 160705.0, 160948.0, 15543.0, 15679.216039197994, 15749.346318636608, 15800.92099539518, 16084.919575402047, 24571.3857153569, 24592.262232133064, 24627.0, 24691.62962555563, 24731.752682473303, 10415.583376665, 10503.894961050291, 10668.093212076905, 10811.78376432467, 10925.617603384002, 9993.450360230112, 9998.900010999942, 10059.195264378832, 10113.887472378032, 10145.64490242838, 9515.524223788783, 9517.809643807084, 9682.951585242028, 9712.22302215821, 9939.453330066772, 2772.6118343431936, 2798.580212968071, 2913.810602310843, 2931.1939216715573, 2990.8355040472984, 1030.3817709374316, 1050.9211809114195, 1058.7300238439302, 1061.5594528270835, 1061.6443491430457, 19901.402957911287, 20559.58880822375, 20945.685814712793, 20967.161313547287, 21116.04977776004, 1099.0932480703452, 1108.14672702019, 1114.5820317380983, 1122.7529943412437, 1133.6444125388778, 11266.94366528162, 11659.76680466386, 11679.007284380923, 11731.824022639667, 11784.052342465198, 560365.0, 576244.0, 577842.0, 582260.0, 586266.0, 124397.0, 127961.0, 128544.0, 129430.35284823515, 130608.0, 1101.9779604407868, 1155.8381826544291, 1232.5131573028782, 1256.3341429042623, 1272.7709012377861, 21566.568668626853, 21651.0, 21681.783182167976, 21843.67234491452, 21953.780462195173, 58708.412915872, 60188.0, 61498.385016151056, 62139.68930155501, 63494.36505634885, 79913.0, 80063.59968200122, 80375.0, 80510.1948980526, 80732.59633701794, 14681.48614798477, 14789.11265324084, 14845.0, 14890.851091488947, 14953.476628318393, 23739.287821364695, 23957.16149934744, 24053.398665033514, 24159.637605436285, 24385.0, 19408.4177474676, 19413.0, 19451.416457506297, 19517.12172952192, 19725.605487889876, 16975.320987160376, 17304.0, 17428.302867885144, 17851.285948561912, 18033.008184549977, 19528.21887124499, 19768.110435030172, 19949.401517954484, 20010.0, 20312.796872031682, 14732.337044833223, 14796.334164962387, 14857.405703771728, 14879.25603719788, 14955.40178392852, 18856.434306970812, 19037.14332854997, 19093.71359429582, 19480.512987175432, 19646.214151434353], "value": 12660.282746430616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.8267042614034, 1393.3312010235093, 1394.4143459746906, 1429.4568064135626, 1429.8641629045237, 15144.697106057885, 15548.378064877392, 15571.922140389297, 15585.376584936588, 15599.84400155998, 14995.47515836946, 15016.0, 15066.773998390034, 15189.4683686071, 15290.770638440405, 2819.732125448079, 2859.8141120827186, 2887.6101726266893, 2915.489789286877, 2917.6790553039255, 2815.0, 2817.506936286152, 2832.0654184119294, 2832.3910359272754, 2833.9999999999895, 2764.7097054809255, 2853.2866783304175, 2857.499812598392, 2860.199144239616, 2862.0984389917107, 2835.376217232206, 2860.127661063375, 2871.1530098620956, 2872.210142210898, 2875.971240287591, 2693.62289279501, 2696.784257259434, 2707.1472486166795, 2735.179446166162, 2801.523740964041, 15926.601834954103, 16089.839101608952, 16099.03405795656, 16112.75830862538, 16112.838871611251, 8285.751427457186, 8591.871121933176, 8597.441166324168, 8608.52653104079, 8618.913810861874, 5729.512991395736, 5810.302763668386, 5933.732982015819, 6042.12389203563, 6107.7556897724035, 2071.7099606055162, 2088.895555222233, 2096.2663067926105, 2117.174302022197, 2127.585120901425, 28438.857805711046, 28624.71375286241, 28640.713592864013, 28688.713112868812, 28738.0, 7053.68258428372, 7090.680919358641, 7115.89326160108, 7270.309320614533, 7283.397652516438, 18936.337228196946, 19070.523236919187, 19120.0, 19128.904355478135, 19133.8086619132, 8257.42198046143, 8414.621342039623, 8460.238578527962, 8464.0, 8465.746027619181, 7612.885806712904, 7623.275788800055, 7832.37341012729, 7835.960820195863, 7846.0, 5394.487523685244, 5580.135079062752, 5593.552515798727, 5603.495685388253, 5665.886682266414, 1629.5030015845043, 1645.0801665954314, 1653.3634550698068, 1659.4357918307833, 1671.7879537335577, 970.0784254957819, 973.4645944730512, 978.6525783346809, 993.4635296939572, 1001.0740065439439, 8323.875141872755, 8335.541545215072, 8382.036065852504, 8393.328533717287, 8474.703385381483, 751.2825251884437, 772.1313522287427, 784.9364111628774, 786.3119770201074, 798.9161138080534, 5301.867453313621, 5677.0, 5993.520518358521, 6020.217371741645, 6025.246844144482, 23113.19103831358, 23353.299401017997, 23807.880960595085, 24116.63825042626, 24529.877350613133, 23940.88029559841, 24089.63865542018, 24212.515749684906, 24216.152434664702, 24376.87811560931, 10801.405922674172, 11940.641780746591, 11943.820842687366, 11950.402479875971, 12047.33739644328, 9365.85951210746, 9368.859467108136, 9404.153626173676, 9415.576299066695, 9455.290853185901, 19781.901090494455, 20155.09302081439, 20291.188352466328, 20304.79695203029, 20524.794752052287, 20411.79588204099, 20721.378358649265, 20772.584548309253, 20816.27143049986, 20900.686489702362, 12113.75772484563, 12304.446299916346, 12307.138500304893, 12316.507339706312, 12334.876651233373, 15017.174055427056, 15062.246887655792, 15115.168665723491, 15299.388024478896, 15343.769843452134, 11651.825222621837, 11680.007199387806, 11687.18189726711, 12137.817932731192, 12221.57224497174, 11749.588764393206, 12127.151099422956, 12143.514259429523, 12274.693132671755, 12288.262704237774, 9831.262655300738, 10111.696649100539, 10116.89883101189, 10117.08946194846, 10124.493775311057, 7712.884306735516, 7750.922490775246, 7823.178566250689, 7893.723719669784, 7897.723579674684, 8014.679412823421, 8128.918710813053, 8146.83706325882, 8190.221928916743, 8273.420860539705], "value": 7078.972997472895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.2090915899047, 544.9100898351771, 557.7573755416394, 566.9886602267958, 570.6433479075578, 6287.968560157198, 6294.779682711106, 6329.715162817679, 6384.776532821352, 6411.294757576663, 6182.814515564529, 6198.132261483396, 6221.7822376216845, 6238.752249550085, 6262.279837818653, 5058.721770302632, 5059.178695669556, 5083.110455670261, 5100.209467532539, 5127.230915362707, 5016.247562865581, 5030.044291584605, 5063.341765570471, 5077.213031980031, 5115.616328775338, 4780.139574876521, 5004.324416203821, 5020.7740651670765, 5031.245313203012, 5043.0, 4843.636727245453, 4861.197902346109, 4873.902521949577, 4876.585490233334, 4884.487128851455, 4388.275934470808, 4427.313766366218, 4432.426488596566, 4471.932921006188, 4488.84289049885, 5945.651467670246, 5970.373110823344, 6022.590963614589, 6042.519582702266, 6050.152978583002, 5671.6880571568545, 5723.885522289573, 5748.540116790688, 5784.334801497797, 5788.768449262025, 6510.772122975721, 6521.804345869631, 6523.380278873499, 6570.0, 6604.834879128012, 4943.728094954776, 4948.901021979576, 4951.504849515056, 4970.204767237261, 4987.750612469362, 6616.470682345401, 6768.76309329176, 6775.898361524581, 6835.965820170917, 6889.689963951584, 5094.0, 5098.617603679665, 5128.743562821844, 5151.5878729701535, 5171.844844654666, 5162.716050617252, 5174.456682048331, 5214.270002199695, 5214.348206474191, 5255.868603284948, 5715.428457154251, 5738.426157384228, 5782.6819524925695, 5788.5369170466265, 5810.12848072784, 6600.86798264032, 6620.139381880421, 6623.768168114189, 6643.966780166068, 6673.132492775908, 1783.0728021428783, 1786.5444311700433, 1796.5059608607476, 1801.8738688291694, 1803.5761596024925, 1202.7323260001606, 1268.029957082814, 1269.4668239339499, 1281.0648226794492, 1281.4938099450665, 6105.145279660851, 6145.938540614626, 6166.136740856284, 6166.383361663798, 6205.2553693557065, 6649.900251496231, 6674.365935236242, 6676.0, 6704.229013663394, 6741.359570840762, 5917.822465326047, 6089.208402907594, 6131.233595800525, 6167.660778657128, 6167.6916154193, 3441.741869359758, 3458.844352004166, 3476.3568739783223, 3495.7378196635354, 3528.241428092921, 6612.404883560503, 6694.263631000586, 6697.22981857083, 6771.695273712695, 6859.039734437183, 6681.231658359351, 6734.528582999241, 6757.229535890359, 6783.287754785775, 6783.932160678429, 6683.43190828785, 6767.1879374475375, 6826.214985276757, 6866.279040700754, 6878.55289406187, 6564.704588293443, 6594.670266486753, 6648.800535983928, 6674.232463266787, 6702.19573651165, 6576.698155645486, 6650.634215118215, 6675.165604299463, 6704.76533321351, 6709.228438729609, 6709.698063587052, 6798.8640227196165, 6826.726930922708, 6834.726610935706, 6856.731504671652, 5081.364829396325, 5107.514786095315, 5112.082968886668, 5134.383873935151, 5158.432572417106, 6485.24898277453, 6573.80278591643, 6578.309277525791, 6592.340765923369, 6713.429358504582, 6339.2392912850755, 6390.520710946605, 6391.631029934877, 6464.2889282177985, 6471.385218404244, 6355.904661430175, 6361.554691171574, 6379.425851673372, 6400.39196276353, 6474.287828338973, 6265.56141070139, 6291.842703932438, 6297.496200303873, 6317.357487053491, 6378.585391949508, 6385.106085148176, 6479.352064793483, 6489.1888513935755, 6495.798277318711, 6521.771737989147, 6182.270563019204, 6301.779437719658, 6311.905321420274, 6370.713317900613, 6397.272736361063], "value": 5105.469207322819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.530785223093, 985.19706439252, 1006.3358183598822, 1010.3180353261547, 1018.775869308752, 18156.18297176627, 18186.727199092024, 18872.716909246374, 19215.519612009706, 19220.0, 17745.91127044363, 17937.730934036, 17969.460916172535, 17980.190891409886, 17996.55008624785, 1041.9583216671342, 1058.8147074262013, 1059.7403636109163, 1061.7451811565206, 1062.2351906627216, 1072.7264547540367, 1073.5598404654093, 1073.5866691323818, 1074.2319241742152, 1075.6127793994156, 1080.9027187553118, 1126.3804907300992, 1130.4630300607187, 1131.9377434241114, 1134.2683968840092, 1116.3246236027169, 1130.3952385473815, 1131.3890499130541, 1133.8696049954237, 1133.8979491845732, 795.852767238057, 810.9918900811034, 813.5484805932705, 817.9263866252065, 823.279630323467, 20529.178832846817, 20535.794642053537, 20595.382138535868, 20661.276855309992, 20661.8966905166, 22887.885560572257, 22979.310620681405, 23019.424514387276, 23108.884455577616, 23122.65316020261, 17681.292748290052, 17766.11169441536, 18085.0, 18116.818831811644, 18158.45524634263, 3969.7816620085882, 3988.880333589997, 3994.800259986989, 3994.840206391741, 3997.8400863965408, 127466.0, 150676.2466187662, 152606.0, 153918.0, 156953.99999999886, 18033.008184549977, 18216.36242731498, 18261.086945652663, 18347.0, 18690.71963920542, 32899.67100328966, 33971.49042764361, 34069.0, 34142.0, 34157.14607134841, 9134.314926380548, 9153.0, 9225.12361325673, 9227.215686666708, 9236.0, 4512.842050528216, 4575.062112266977, 4609.1703493371515, 4616.238320677118, 4625.190591646516, 5813.6221145625395, 6030.246219222598, 6066.878662426815, 6099.451049405486, 6103.115048317969, 1171.1041053594008, 1180.1974657233163, 1186.6736647422028, 1224.8285240066398, 1225.154643296123, 720.0747040053611, 741.8553382090548, 743.2196193996282, 743.5761615879005, 761.482192109371, 12523.311217883103, 12626.873731262753, 12927.418266178045, 12948.611541653765, 13192.894136213981, 743.2641684732184, 743.434989408043, 744.1702501710662, 750.1335956969709, 757.9734709285149, 5565.332160140728, 5590.161475778666, 5645.23789288449, 5652.547796176296, 5658.207850900877, 146352.0, 146771.0, 147209.0, 148245.0, 150893.24553377382, 127857.36071319584, 129780.0, 131825.34087329693, 134343.0, 134671.0, 113538.43230783794, 115006.0, 116087.0, 116917.41541292239, 117579.41210293894, 10679.51942162589, 10932.508037138507, 10973.067289280501, 11028.503717332578, 11165.16261280391, 47021.76489117533, 47814.760926195144, 47856.282155766996, 48235.5176448231, 48653.0, 62299.688501557204, 62576.0, 62672.68663656653, 64224.0, 65656.67171664111, 17495.30018799234, 17665.470035898943, 17745.733813993058, 17774.46676599704, 17798.822011780234, 18109.456716298533, 18113.0, 18174.27302907869, 18255.087245637398, 18287.085645717925, 17752.822471775635, 18157.727634085764, 18178.45464636063, 18226.72659910129, 18403.355882544045, 17332.480025599252, 17436.47690569285, 17538.82461175372, 17697.20362583661, 17827.554311142325, 18035.729464058313, 18036.188371523574, 18166.5458363542, 18192.636147276717, 18275.908620456812, 12893.35533223354, 13021.153625014344, 13064.673383165496, 13354.799678005033, 13438.46246150143, 13029.869701302865, 13039.608811735663, 13328.1391248755, 13391.263480508665, 13520.797188042385], "value": 9725.263239437718, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 106.0, 106.0, 106.0, 108.0, 105.0, 105.0, 106.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 114.0, 113.0, 115.0, 112.0, 116.0, 113.0, 117.0, 146.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 163.0, 160.0, 163.0, 162.0, 163.0, 166.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 76.0, 77.0, 77.0, 78.0, 77.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 113.0, 115.0, 118.0, 114.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 149.0, 157.0, 151.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 46.0, 44.0, 45.0, 45.0, 46.0, 46.0, 44.0, 44.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 37.0, 36.0], "value": 36.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 75.0, 71.0, 73.0, 71.0, 72.0, 81.0, 73.0, 77.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 108.0, 111.0, 108.0, 110.0, 121.0, 107.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 152.0, 159.0, 163.0, 154.0, 159.0, 157.0, 155.0, 152.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 58.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0], "value": 60.3, "unit": "score"}]}]} 00:53:57 INFO - Return code: 0 00:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:53:57 INFO - # TBPL SUCCESS # 00:53:57 INFO - Running post-action listener: _package_coverage_data 00:53:57 INFO - Running post-action listener: _resource_record_post_action 00:53:57 INFO - [mozharness: 2017-09-14 07:53:57.906319Z] Finished run-tests step (success) 00:53:57 INFO - Running post-run listener: _resource_record_post_run 00:53:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 338292736; Read time: 348; Write time: 321596 00:53:57 INFO - TinderboxPrint: CPU usage
13.1% 00:53:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 348 00:53:57 INFO - TinderboxPrint: I/O write bytes / time
338,292,736 / 321,596 00:53:57 INFO - TinderboxPrint: CPU idle
8,218.7 (86.9%) 00:53:57 INFO - TinderboxPrint: CPU user
1,188.1 (12.6%) 00:53:57 INFO - TinderboxPrint: Swap in / out
0 / 0 00:53:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10686464; Read time: 0; Write time: 808 00:53:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:53:58 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327606272; Read time: 348; Write time: 320788 00:53:58 INFO - Running post-run listener: _upload_blobber_files 00:53:58 INFO - Blob upload gear active. 00:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:53:58 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 00:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:53:58 INFO - (blobuploader) - INFO - Open directory for files ... 00:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:00 INFO - (blobuploader) - INFO - Done attempting. 00:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:54:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:07 INFO - (blobuploader) - INFO - Done attempting. 00:54:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:54:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:08 INFO - (blobuploader) - INFO - Done attempting. 00:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:09 INFO - (blobuploader) - INFO - Done attempting. 00:54:09 INFO - (blobuploader) - INFO - Iteration through files over. 00:54:09 INFO - Return code: 0 00:54:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:54:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:54:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/942aa0f2ffb6f183651aba9fb381b0ed17806e3b263e4eb5ce9a21ce710547b8f066b9e2fed90d8a6e91011438e37f7ca3d0e526d2478a9aa09f7366225085de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc62e75e5dd3c4e05e4719f31d667d03c5c6e8b4015919a454b8af9cd21aff2c0a3f206307b5a15a1bb645cdc30c1b618ba517c5410594ba8a309b3d280a18", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce0f827a5bd2fdb57f8f1069e8ee0d6e8ff6ea53faddcffef6370fef16964934d6fb5a3a96de02473332bccc0e1fb530ed42926d2a060762801b3baceae35e0b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0041d6a658027c49b8598691d1eda212897a920c93b217346e42c15c3a93e1e46c41d95d608820b3b596dbf40e9fe9088723bd64b8c56ab5b743222e2be5e0e3"} 00:54:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:54:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:54:09 INFO - Contents: 00:54:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/942aa0f2ffb6f183651aba9fb381b0ed17806e3b263e4eb5ce9a21ce710547b8f066b9e2fed90d8a6e91011438e37f7ca3d0e526d2478a9aa09f7366225085de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc62e75e5dd3c4e05e4719f31d667d03c5c6e8b4015919a454b8af9cd21aff2c0a3f206307b5a15a1bb645cdc30c1b618ba517c5410594ba8a309b3d280a18", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce0f827a5bd2fdb57f8f1069e8ee0d6e8ff6ea53faddcffef6370fef16964934d6fb5a3a96de02473332bccc0e1fb530ed42926d2a060762801b3baceae35e0b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0041d6a658027c49b8598691d1eda212897a920c93b217346e42c15c3a93e1e46c41d95d608820b3b596dbf40e9fe9088723bd64b8c56ab5b743222e2be5e0e3"} 00:54:09 INFO - Running post-run listener: copy_logs_to_upload_dir 00:54:09 INFO - Copying logs to upload dir... 00:54:09 INFO - mkdir: /builds/slave/test/build/upload/logs 00:54:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.589573 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 00:54:09.688058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:09.695010) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/942aa0f2ffb6f183651aba9fb381b0ed17806e3b263e4eb5ce9a21ce710547b8f066b9e2fed90d8a6e91011438e37f7ca3d0e526d2478a9aa09f7366225085de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc62e75e5dd3c4e05e4719f31d667d03c5c6e8b4015919a454b8af9cd21aff2c0a3f206307b5a15a1bb645cdc30c1b618ba517c5410594ba8a309b3d280a18", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce0f827a5bd2fdb57f8f1069e8ee0d6e8ff6ea53faddcffef6370fef16964934d6fb5a3a96de02473332bccc0e1fb530ed42926d2a060762801b3baceae35e0b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0041d6a658027c49b8598691d1eda212897a920c93b217346e42c15c3a93e1e46c41d95d608820b3b596dbf40e9fe9088723bd64b8c56ab5b743222e2be5e0e3"} build_url:https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/A80n8hY7R3ez-LhoDFyx5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/942aa0f2ffb6f183651aba9fb381b0ed17806e3b263e4eb5ce9a21ce710547b8f066b9e2fed90d8a6e91011438e37f7ca3d0e526d2478a9aa09f7366225085de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc62e75e5dd3c4e05e4719f31d667d03c5c6e8b4015919a454b8af9cd21aff2c0a3f206307b5a15a1bb645cdc30c1b618ba517c5410594ba8a309b3d280a18", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce0f827a5bd2fdb57f8f1069e8ee0d6e8ff6ea53faddcffef6370fef16964934d6fb5a3a96de02473332bccc0e1fb530ed42926d2a060762801b3baceae35e0b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0041d6a658027c49b8598691d1eda212897a920c93b217346e42c15c3a93e1e46c41d95d608820b3b596dbf40e9fe9088723bd64b8c56ab5b743222e2be5e0e3"}' ========= master_lag: 1.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:11.021956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:11.022349) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505373947.98193-1060614636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:11.045040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:54:11.045337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:54:11.052468) ========= ========= Total master_lag: 1.50 =========