builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1503099999.36 results: success (0) revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.357506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.358093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.358384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.374638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.375079) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 16:46:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-08-18 16:46:39 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.209165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.599524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.599884) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018465 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.661711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:39.662071) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f4487cc2d30d988742109868dcf21c4113f12f5 --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 4f4487cc2d30d988742109868dcf21c4113f12f5 --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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 16:46:39,821 truncating revision to first 12 chars 2017-08-18 16:46:39,821 Setting DEBUG logging. 2017-08-18 16:46:39,821 attempt 1/10 2017-08-18 16:46:39,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f4487cc2d30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 16:46:40,470 unpacking tar archive at: mozilla-central-4f4487cc2d30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:40.648021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:40.648351) ========= script_repo_revision: 4f4487cc2d30d988742109868dcf21c4113f12f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:40.648757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:40.649035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 16:46:40.661052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-18 16:46:40.661355) ========= /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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:46:40 INFO - MultiFileLogger online at 20170818 16:46:40 in /builds/slave/test 16:46:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:46:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:40 INFO - {'append_to_log': False, 16:46:40 INFO - 'base_work_dir': '/builds/slave/test', 16:46:40 INFO - 'blob_upload_branch': 'Firefox', 16:46:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:40 INFO - 'branch': 'Firefox', 16:46:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:40 INFO - 'code_coverage': False, 16:46:40 INFO - 'config_files': ('talos/linux_config.py',), 16:46:40 INFO - 'default_actions': ('clobber', 16:46:40 INFO - 'read-buildbot-config', 16:46:40 INFO - 'download-and-extract', 16:46:40 INFO - 'populate-webroot', 16:46:40 INFO - 'create-virtualenv', 16:46:40 INFO - 'install', 16:46:40 INFO - 'setup-mitmproxy', 16:46:40 INFO - 'run-tests'), 16:46:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:40 INFO - 'disable_ccov_upload': False, 16:46:40 INFO - 'download_minidump_stackwalk': True, 16:46:40 INFO - 'download_symbols': 'ondemand', 16:46:40 INFO - 'enable_stylo': False, 16:46:40 INFO - 'enable_webrender': False, 16:46:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:40 INFO - 'gecko_profile': False, 16:46:40 INFO - 'gecko_profile_interval': 0, 16:46:40 INFO - 'installer_path': 'installer.exe', 16:46:40 INFO - 'log_level': 'info', 16:46:40 INFO - 'log_name': 'talos', 16:46:40 INFO - 'log_to_console': True, 16:46:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:46:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:46:40 INFO - 'opt_config_files': (), 16:46:40 INFO - 'pip_index': False, 16:46:40 INFO - 'suite': 'dromaeojs-e10s', 16:46:40 INFO - 'system_bits': '32', 16:46:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:40 INFO - 'title': 'talos-linux64-ix-029', 16:46:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:40 INFO - 'use_talos_json': True, 16:46:40 INFO - 'verify': 'False', 16:46:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:40 INFO - 'work_dir': 'build'} 16:46:40 INFO - [mozharness: 2017-08-18 23:46:40.964264Z] Running clobber step. 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: clobber 16:46:40 INFO - rmtree: /builds/slave/test/build 16:46:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:41 INFO - Running post-action listener: _resource_record_post_action 16:46:41 INFO - [mozharness: 2017-08-18 23:46:41.981031Z] Finished clobber step (success) 16:46:41 INFO - [mozharness: 2017-08-18 23:46:41.981128Z] Running read-buildbot-config step. 16:46:41 INFO - Running pre-action listener: _resource_record_pre_action 16:46:41 INFO - Running main action method: read_buildbot_config 16:46:41 INFO - Using buildbot properties: 16:46:41 INFO - { 16:46:41 INFO - "project": "", 16:46:41 INFO - "product": "firefox", 16:46:41 INFO - "who": "kwierso@gmail.com", 16:46:41 INFO - "installer_path": "public/build/target.tar.bz2", 16:46:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:46:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:46:41 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:46:41 INFO - "stage_platform": "linux64-stylo", 16:46:41 INFO - "basedir": "/builds/slave/test", 16:46:41 INFO - "buildnumber": 91, 16:46:41 INFO - "platform": "ubuntu64_hw_stylo", 16:46:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:46:41 INFO - "slavebuilddir": "test", 16:46:41 INFO - "taskId": "RptxG3E0SYy7MUV967WaFw", 16:46:41 INFO - "branch": "mozilla-central", 16:46:41 INFO - "script_repo_revision": "production", 16:46:41 INFO - "revision": "4f4487cc2d30d988742109868dcf21c4113f12f5", 16:46:41 INFO - "slavename": "talos-linux64-ix-029", 16:46:41 INFO - "repo_path": "mozilla-central" 16:46:41 INFO - } 16:46:41 INFO - Finding installer, test and symbols from parent task. 16:46:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RptxG3E0SYy7MUV967WaFw'}, attempt #1 16:46:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RptxG3E0SYy7MUV967WaFw'}, attempt #1 16:46:42 INFO - Task dependencies: MG9qgLVdSh6Lrf5lTYxwFA 16:46:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA'}, attempt #1 16:46:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:46:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json 16:46:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip 16:46:43 INFO - Running post-action listener: _resource_record_post_action 16:46:43 INFO - [mozharness: 2017-08-18 23:46:43.354277Z] Finished read-buildbot-config step (success) 16:46:43 INFO - [mozharness: 2017-08-18 23:46:43.354496Z] Running download-and-extract step. 16:46:43 INFO - Running pre-action listener: _resource_record_pre_action 16:46:43 INFO - Running main action method: download_and_extract 16:46:43 INFO - mkdir: /builds/slave/test/build/tests 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:43 INFO - trying https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json 16:46:43 INFO - Downloading https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:46:43 INFO - Downloaded 989 bytes. 16:46:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:46:43 INFO - Using the following test package requirements: 16:46:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:46:43 INFO - u'common': [u'target.common.tests.zip'], 16:46:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:46:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:46:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:46:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:46:43 INFO - u'mozbase': [u'target.common.tests.zip'], 16:46:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:46:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:46:43 INFO - u'web-platform': [u'target.common.tests.zip', 16:46:43 INFO - u'target.web-platform.tests.tar.gz'], 16:46:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:46:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:46:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip 16:46:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:46:43 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip into memory 16:46:44 INFO - Content-Length response header: 54005097 16:46:44 INFO - Bytes received: 54005097 16:46:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:46:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip 16:46:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:46:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.common.tests.zip into memory 16:46:57 INFO - Content-Length response header: 54005097 16:46:57 INFO - Bytes received: 54005097 16:47:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip 16:47:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:47:08 INFO - Fetch https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.talos.tests.zip into memory 16:47:09 INFO - Content-Length response header: 14496256 16:47:09 INFO - Bytes received: 14496256 16:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:09 INFO - trying https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:47:09 INFO - Downloading https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:47:11 INFO - Downloaded 62133216 bytes. 16:47:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:47:11 INFO - mkdir: /builds/slave/test/properties 16:47:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:47:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:47:11 INFO - Contents: 16:47:11 INFO - build_url:https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 16:47:11 INFO - Running post-action listener: _resource_record_post_action 16:47:11 INFO - Running post-action listener: find_tests_for_verification 16:47:11 INFO - Running post-action listener: set_extra_try_arguments 16:47:11 INFO - [mozharness: 2017-08-18 23:47:11.063992Z] Finished download-and-extract step (success) 16:47:11 INFO - [mozharness: 2017-08-18 23:47:11.064089Z] Running populate-webroot step. 16:47:11 INFO - Running pre-action listener: _resource_record_pre_action 16:47:11 INFO - Running main action method: populate_webroot 16:47:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:47:11 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:47:11 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:11 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'tests': ['damp', 'tps']}, 16:47:11 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['damp', 'tps']}, 16:47:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:47:11 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:47:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:47:11 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:47:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:47:11 INFO - 'ts_paint', 16:47:11 INFO - 'tpaint', 16:47:11 INFO - 'sessionrestore', 16:47:11 INFO - 'sessionrestore_many_windows', 16:47:11 INFO - 'sessionrestore_no_auto_restore', 16:47:11 INFO - 'tabpaint']}, 16:47:11 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['a11yr', 16:47:11 INFO - 'ts_paint', 16:47:11 INFO - 'tpaint', 16:47:11 INFO - 'sessionrestore', 16:47:11 INFO - 'sessionrestore_many_windows', 16:47:11 INFO - 'sessionrestore_no_auto_restore', 16:47:11 INFO - 'tabpaint']}, 16:47:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:47:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:47:11 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['bloom_basic_singleton']}, 16:47:11 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['bloom_basic']}, 16:47:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:47:11 INFO - 'tsvgr_opacity', 16:47:11 INFO - 'tart', 16:47:11 INFO - 'tscrollx', 16:47:11 INFO - 'tsvg_static']}, 16:47:11 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['tsvgx', 16:47:11 INFO - 'tsvgr_opacity', 16:47:11 INFO - 'tart', 16:47:11 INFO - 'tscrollx', 16:47:11 INFO - 'tsvg_static']}, 16:47:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:47:11 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--stylo'], 16:47:11 INFO - 'tests': ['tp5o']}, 16:47:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:47:11 INFO - 'talos_options': ['--mitmproxy', 16:47:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:47:11 INFO - '--firstNonBlankPaint'], 16:47:11 INFO - 'tests': ['tp6_google', 16:47:11 INFO - 'tp6_youtube', 16:47:11 INFO - 'tp6_amazon', 16:47:11 INFO - 'tp6_facebook']}, 16:47:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:47:11 INFO - 'talos_options': ['--stylo', 16:47:11 INFO - '--mitmproxy', 16:47:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:47:11 INFO - '--firstNonBlankPaint'], 16:47:11 INFO - 'tests': ['tp6_google', 16:47:11 INFO - 'tp6_youtube', 16:47:11 INFO - 'tp6_amazon', 16:47:11 INFO - 'tp6_facebook']}, 16:47:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:47:11 INFO - 'talos_options': ['--stylo', 16:47:11 INFO - '--stylo-threads=1', 16:47:11 INFO - '--mitmproxy', 16:47:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:47:11 INFO - '--firstNonBlankPaint'], 16:47:11 INFO - 'tests': ['tp6_google', 16:47:11 INFO - 'tp6_youtube', 16:47:11 INFO - 'tp6_amazon', 16:47:11 INFO - 'tp6_facebook']}, 16:47:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--xperf_path', 16:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:11 INFO - 'tests': ['tp5n']}, 16:47:11 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:47:11 INFO - 'talos_options': ['--stylo', 16:47:11 INFO - '--xperf_path', 16:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:11 INFO - 'tests': ['tp5n']}}} 16:47:11 INFO - Running post-action listener: _resource_record_post_action 16:47:11 INFO - [mozharness: 2017-08-18 23:47:11.078270Z] Finished populate-webroot step (success) 16:47:11 INFO - [mozharness: 2017-08-18 23:47:11.078359Z] Running create-virtualenv step. 16:47:11 INFO - Running pre-action listener: _resource_record_pre_action 16:47:11 INFO - Running main action method: create_virtualenv 16:47:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:47:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:47:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:47:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:47:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:11 INFO - Using real prefix '/usr' 16:47:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:47:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:13 INFO - Installing pip.................done. 16:47:13 INFO - Return code: 0 16:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:47:13 INFO - Reading from file tmpfile_stdout 16:47:13 INFO - Output received: 16:47:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:47:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:13 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:47:13 INFO - Using env: {'DISPLAY': ':0', 16:47:13 INFO - 'HOME': '/home/cltbld', 16:47:13 INFO - 'LANG': 'en_US.UTF-8', 16:47:13 INFO - 'LANGUAGE': 'en_US:en', 16:47:13 INFO - 'LOGNAME': 'cltbld', 16:47:13 INFO - 'MAIL': '/var/mail/cltbld', 16:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:13 INFO - 'MOZ_NO_REMOTE': '1', 16:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:13 INFO - 'NO_EM_RESTART': '1', 16:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:13 INFO - 'PWD': '/builds/slave/test', 16:47:13 INFO - 'SHELL': '/bin/bash', 16:47:13 INFO - 'SHLVL': '1', 16:47:13 INFO - 'TERM': 'linux', 16:47:13 INFO - 'TMOUT': '86400', 16:47:13 INFO - 'USER': 'cltbld', 16:47:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:13 INFO - '_': '/tools/buildbot/bin/python'} 16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:14 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:47:14 INFO - Using env: {'DISPLAY': ':0', 16:47:14 INFO - 'HOME': '/home/cltbld', 16:47:14 INFO - 'LANG': 'en_US.UTF-8', 16:47:14 INFO - 'LANGUAGE': 'en_US:en', 16:47:14 INFO - 'LOGNAME': 'cltbld', 16:47:14 INFO - 'MAIL': '/var/mail/cltbld', 16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:14 INFO - 'MOZ_NO_REMOTE': '1', 16:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:14 INFO - 'NO_EM_RESTART': '1', 16:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:14 INFO - 'PWD': '/builds/slave/test', 16:47:14 INFO - 'SHELL': '/bin/bash', 16:47:14 INFO - 'SHLVL': '1', 16:47:14 INFO - 'TERM': 'linux', 16:47:14 INFO - 'TMOUT': '86400', 16:47:14 INFO - 'USER': 'cltbld', 16:47:14 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:14 INFO - '_': '/tools/buildbot/bin/python'} 16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:14 INFO - Downloading/unpacking psutil>=3.1.1 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:15 INFO - Installing collected packages: psutil 16:47:15 INFO - Running setup.py install for psutil 16:47:15 INFO - building 'psutil._psutil_linux' extension 16:47:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:47:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:47:15 INFO - building 'psutil._psutil_posix' extension 16:47:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:47:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:16 INFO - Successfully installed psutil 16:47:16 INFO - Cleaning up... 16:47:16 INFO - Return code: 0 16:47:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:16 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:47:16 INFO - Using env: {'DISPLAY': ':0', 16:47:16 INFO - 'HOME': '/home/cltbld', 16:47:16 INFO - 'LANG': 'en_US.UTF-8', 16:47:16 INFO - 'LANGUAGE': 'en_US:en', 16:47:16 INFO - 'LOGNAME': 'cltbld', 16:47:16 INFO - 'MAIL': '/var/mail/cltbld', 16:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:16 INFO - 'MOZ_NO_REMOTE': '1', 16:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:16 INFO - 'NO_EM_RESTART': '1', 16:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:16 INFO - 'PWD': '/builds/slave/test', 16:47:16 INFO - 'SHELL': '/bin/bash', 16:47:16 INFO - 'SHLVL': '1', 16:47:16 INFO - 'TERM': 'linux', 16:47:16 INFO - 'TMOUT': '86400', 16:47:16 INFO - 'USER': 'cltbld', 16:47:16 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:16 INFO - '_': '/tools/buildbot/bin/python'} 16:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:17 INFO - Installing collected packages: mozsystemmonitor 16:47:17 INFO - Running setup.py install for mozsystemmonitor 16:47:17 INFO - Successfully installed mozsystemmonitor 16:47:17 INFO - Cleaning up... 16:47:17 INFO - Return code: 0 16:47:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:17 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:47:17 INFO - Using env: {'DISPLAY': ':0', 16:47:17 INFO - 'HOME': '/home/cltbld', 16:47:17 INFO - 'LANG': 'en_US.UTF-8', 16:47:17 INFO - 'LANGUAGE': 'en_US:en', 16:47:17 INFO - 'LOGNAME': 'cltbld', 16:47:17 INFO - 'MAIL': '/var/mail/cltbld', 16:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:17 INFO - 'MOZ_NO_REMOTE': '1', 16:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:17 INFO - 'NO_EM_RESTART': '1', 16:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:17 INFO - 'PWD': '/builds/slave/test', 16:47:17 INFO - 'SHELL': '/bin/bash', 16:47:17 INFO - 'SHLVL': '1', 16:47:17 INFO - 'TERM': 'linux', 16:47:17 INFO - 'TMOUT': '86400', 16:47:17 INFO - 'USER': 'cltbld', 16:47:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:17 INFO - '_': '/tools/buildbot/bin/python'} 16:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:19 INFO - warning: no files found matching '*.txt' 16:47:19 INFO - no previously-included directories found matching 'build' 16:47:19 INFO - no previously-included directories found matching 'dist' 16:47:19 INFO - no previously-included directories found matching '.git*' 16:47:19 INFO - Installing collected packages: jsonschema, functools32 16:47:19 INFO - Running setup.py install for functools32 16:47:19 INFO - warning: no files found matching '*.txt' 16:47:19 INFO - no previously-included directories found matching 'build' 16:47:19 INFO - no previously-included directories found matching 'dist' 16:47:19 INFO - no previously-included directories found matching '.git*' 16:47:19 INFO - Successfully installed jsonschema functools32 16:47:19 INFO - Cleaning up... 16:47:19 INFO - Return code: 0 16:47:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:19 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:47:19 INFO - Using env: {'DISPLAY': ':0', 16:47:19 INFO - 'HOME': '/home/cltbld', 16:47:19 INFO - 'LANG': 'en_US.UTF-8', 16:47:19 INFO - 'LANGUAGE': 'en_US:en', 16:47:19 INFO - 'LOGNAME': 'cltbld', 16:47:19 INFO - 'MAIL': '/var/mail/cltbld', 16:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:19 INFO - 'MOZ_NO_REMOTE': '1', 16:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:19 INFO - 'NO_EM_RESTART': '1', 16:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:19 INFO - 'PWD': '/builds/slave/test', 16:47:19 INFO - 'SHELL': '/bin/bash', 16:47:19 INFO - 'SHLVL': '1', 16:47:19 INFO - 'TERM': 'linux', 16:47:19 INFO - 'TMOUT': '86400', 16:47:19 INFO - 'USER': 'cltbld', 16:47:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:19 INFO - '_': '/tools/buildbot/bin/python'} 16:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:19 INFO - Cleaning up... 16:47:19 INFO - Return code: 0 16:47:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:19 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:47:19 INFO - Using env: {'DISPLAY': ':0', 16:47:19 INFO - 'HOME': '/home/cltbld', 16:47:19 INFO - 'LANG': 'en_US.UTF-8', 16:47:19 INFO - 'LANGUAGE': 'en_US:en', 16:47:19 INFO - 'LOGNAME': 'cltbld', 16:47:19 INFO - 'MAIL': '/var/mail/cltbld', 16:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:19 INFO - 'MOZ_NO_REMOTE': '1', 16:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:19 INFO - 'NO_EM_RESTART': '1', 16:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:19 INFO - 'PWD': '/builds/slave/test', 16:47:19 INFO - 'SHELL': '/bin/bash', 16:47:19 INFO - 'SHLVL': '1', 16:47:19 INFO - 'TERM': 'linux', 16:47:19 INFO - 'TMOUT': '86400', 16:47:19 INFO - 'USER': 'cltbld', 16:47:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:19 INFO - '_': '/tools/buildbot/bin/python'} 16:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:21 INFO - Downloading docopt-0.6.1.tar.gz 16:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:21 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:21 INFO - Running setup.py install for blobuploader 16:47:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:21 INFO - Running setup.py install for requests 16:47:21 INFO - Running setup.py install for docopt 16:47:21 INFO - Successfully installed blobuploader requests docopt 16:47:21 INFO - Cleaning up... 16:47:21 INFO - Return code: 0 16:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:21 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:21 INFO - Using env: {'DISPLAY': ':0', 16:47:21 INFO - 'HOME': '/home/cltbld', 16:47:21 INFO - 'LANG': 'en_US.UTF-8', 16:47:21 INFO - 'LANGUAGE': 'en_US:en', 16:47:21 INFO - 'LOGNAME': 'cltbld', 16:47:21 INFO - 'MAIL': '/var/mail/cltbld', 16:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:21 INFO - 'MOZ_NO_REMOTE': '1', 16:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:21 INFO - 'NO_EM_RESTART': '1', 16:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:21 INFO - 'PWD': '/builds/slave/test', 16:47:21 INFO - 'SHELL': '/bin/bash', 16:47:21 INFO - 'SHLVL': '1', 16:47:21 INFO - 'TERM': 'linux', 16:47:21 INFO - 'TMOUT': '86400', 16:47:21 INFO - 'USER': 'cltbld', 16:47:21 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:21 INFO - '_': '/tools/buildbot/bin/python'} 16:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:22 INFO - Running setup.py (path:/tmp/pip-h3gcjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:22 INFO - Running setup.py (path:/tmp/pip-LeW7_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:22 INFO - Running setup.py (path:/tmp/pip-AyTQYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:22 INFO - Running setup.py (path:/tmp/pip-wApZw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:22 INFO - Running setup.py (path:/tmp/pip-4U15fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:22 INFO - Running setup.py (path:/tmp/pip-dlECfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:22 INFO - Running setup.py (path:/tmp/pip-S1vwjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:22 INFO - Running setup.py (path:/tmp/pip-gykQNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:22 INFO - Running setup.py (path:/tmp/pip-9twuBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:22 INFO - Running setup.py (path:/tmp/pip-A0Btty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 INFO - Running setup.py (path:/tmp/pip-o5h50O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:22 INFO - Running setup.py (path:/tmp/pip-mGaZlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:23 INFO - Running setup.py (path:/tmp/pip-TVbC92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:23 INFO - Running setup.py (path:/tmp/pip-rALqF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:23 INFO - Running setup.py (path:/tmp/pip-ts6rxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:23 INFO - Running setup.py (path:/tmp/pip-NU6eLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:23 INFO - Running setup.py (path:/tmp/pip-cQCUvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:23 INFO - Running setup.py install for manifestparser 16:47:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozcrash 16:47:23 INFO - Running setup.py install for mozdebug 16:47:23 INFO - Running setup.py install for mozdevice 16:47:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozfile 16:47:23 INFO - Running setup.py install for mozhttpd 16:47:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozinfo 16:47:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozInstall 16:47:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozleak 16:47:24 INFO - Running setup.py install for mozlog 16:47:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for moznetwork 16:47:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozprocess 16:47:24 INFO - Running setup.py install for mozprofile 16:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozrunner 16:47:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozscreenshot 16:47:24 INFO - Running setup.py install for moztest 16:47:25 INFO - Running setup.py install for mozversion 16:47:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:25 INFO - Cleaning up... 16:47:25 INFO - Return code: 0 16:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:25 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:25 INFO - Using env: {'DISPLAY': ':0', 16:47:25 INFO - 'HOME': '/home/cltbld', 16:47:25 INFO - 'LANG': 'en_US.UTF-8', 16:47:25 INFO - 'LANGUAGE': 'en_US:en', 16:47:25 INFO - 'LOGNAME': 'cltbld', 16:47:25 INFO - 'MAIL': '/var/mail/cltbld', 16:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:25 INFO - 'MOZ_NO_REMOTE': '1', 16:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:25 INFO - 'NO_EM_RESTART': '1', 16:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:25 INFO - 'PWD': '/builds/slave/test', 16:47:25 INFO - 'SHELL': '/bin/bash', 16:47:25 INFO - 'SHLVL': '1', 16:47:25 INFO - 'TERM': 'linux', 16:47:25 INFO - 'TMOUT': '86400', 16:47:25 INFO - 'USER': 'cltbld', 16:47:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:25 INFO - '_': '/tools/buildbot/bin/python'} 16:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:25 INFO - Running setup.py (path:/tmp/pip-nPi5m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:25 INFO - Running setup.py (path:/tmp/pip-NALXGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:25 INFO - Running setup.py (path:/tmp/pip-k15z1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:25 INFO - Running setup.py (path:/tmp/pip-2xe8ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:25 INFO - Running setup.py (path:/tmp/pip-DRbkTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:25 INFO - Running setup.py (path:/tmp/pip-Dg7zgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:25 INFO - Running setup.py (path:/tmp/pip-TLtqUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:25 INFO - Running setup.py (path:/tmp/pip-SSdqnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:25 INFO - Running setup.py (path:/tmp/pip-2cfTED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:26 INFO - Running setup.py (path:/tmp/pip-TnM35N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:26 INFO - Running setup.py (path:/tmp/pip-ttzEXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:26 INFO - Running setup.py (path:/tmp/pip-BtLDp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:26 INFO - Running setup.py (path:/tmp/pip-YIGWz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:26 INFO - Running setup.py (path:/tmp/pip-CajGCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:26 INFO - Running setup.py (path:/tmp/pip-jaxBwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:26 INFO - Running setup.py (path:/tmp/pip-2x6rbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:26 INFO - Running setup.py (path:/tmp/pip-B7TO23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:27 INFO - Downloading blessings-1.6.tar.gz 16:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:27 INFO - Installing collected packages: blessings 16:47:27 INFO - Running setup.py install for blessings 16:47:27 INFO - Successfully installed blessings 16:47:27 INFO - Cleaning up... 16:47:27 INFO - Return code: 0 16:47:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:28 INFO - Reading from file tmpfile_stdout 16:47:28 INFO - Current package versions: 16:47:28 INFO - argparse == 1.2.1 16:47:28 INFO - blessings == 1.6 16:47:28 INFO - blobuploader == 1.2.4 16:47:28 INFO - docopt == 0.6.1 16:47:28 INFO - functools32 == 3.2.3-2 16:47:28 INFO - jsonschema == 2.5.1 16:47:28 INFO - manifestparser == 1.1 16:47:28 INFO - mozInstall == 1.13 16:47:28 INFO - mozcrash == 1.0 16:47:28 INFO - mozdebug == 0.1 16:47:28 INFO - mozdevice == 0.51 16:47:28 INFO - mozfile == 1.2 16:47:28 INFO - mozhttpd == 0.7 16:47:28 INFO - mozinfo == 0.10 16:47:28 INFO - mozleak == 0.1 16:47:28 INFO - mozlog == 3.5 16:47:28 INFO - moznetwork == 0.27 16:47:28 INFO - mozprocess == 0.25 16:47:28 INFO - mozprofile == 0.28 16:47:28 INFO - mozrunner == 6.13 16:47:28 INFO - mozscreenshot == 0.1 16:47:28 INFO - mozsystemmonitor == 0.3 16:47:28 INFO - moztest == 0.8 16:47:28 INFO - mozversion == 1.4 16:47:28 INFO - psutil == 3.1.1 16:47:28 INFO - requests == 1.2.3 16:47:28 INFO - wsgiref == 0.1.2 16:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47: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')]} 16:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:28 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:28 INFO - Using env: {'DISPLAY': ':0', 16:47:28 INFO - 'HOME': '/home/cltbld', 16:47:28 INFO - 'LANG': 'en_US.UTF-8', 16:47:28 INFO - 'LANGUAGE': 'en_US:en', 16:47:28 INFO - 'LOGNAME': 'cltbld', 16:47:28 INFO - 'MAIL': '/var/mail/cltbld', 16:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:28 INFO - 'MOZ_NO_REMOTE': '1', 16:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:28 INFO - 'NO_EM_RESTART': '1', 16:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:28 INFO - 'PWD': '/builds/slave/test', 16:47:28 INFO - 'SHELL': '/bin/bash', 16:47:28 INFO - 'SHLVL': '1', 16:47:28 INFO - 'TERM': 'linux', 16:47:28 INFO - 'TMOUT': '86400', 16:47:28 INFO - 'USER': 'cltbld', 16:47:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:28 INFO - '_': '/tools/buildbot/bin/python'} 16:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:47:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:29 INFO - Installing collected packages: simplejson 16:47:29 INFO - Running setup.py install for simplejson 16:47:29 INFO - building 'simplejson._speedups' extension 16:47:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:47:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:47:30 INFO - Successfully installed simplejson 16:47:30 INFO - Cleaning up... 16:47:30 INFO - Return code: 0 16:47:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:30 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 0xf671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1132a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:47:30 INFO - Using env: {'DISPLAY': ':0', 16:47:30 INFO - 'HOME': '/home/cltbld', 16:47:30 INFO - 'LANG': 'en_US.UTF-8', 16:47:30 INFO - 'LANGUAGE': 'en_US:en', 16:47:30 INFO - 'LOGNAME': 'cltbld', 16:47:30 INFO - 'MAIL': '/var/mail/cltbld', 16:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:30 INFO - 'MOZ_NO_REMOTE': '1', 16:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:30 INFO - 'NO_EM_RESTART': '1', 16:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:30 INFO - 'PWD': '/builds/slave/test', 16:47:30 INFO - 'SHELL': '/bin/bash', 16:47:30 INFO - 'SHLVL': '1', 16:47:30 INFO - 'TERM': 'linux', 16:47:30 INFO - 'TMOUT': '86400', 16:47:30 INFO - 'USER': 'cltbld', 16:47:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:30 INFO - '_': '/tools/buildbot/bin/python'} 16:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:47:30 INFO - Cleaning up... 16:47:30 INFO - Return code: 0 16:47:30 INFO - Running post-action listener: _resource_record_post_action 16:47:30 INFO - Running post-action listener: _start_resource_monitoring 16:47:30 INFO - Starting resource monitoring. 16:47:30 INFO - [mozharness: 2017-08-18 23:47:30.847919Z] Finished create-virtualenv step (success) 16:47:30 INFO - [mozharness: 2017-08-18 23:47:30.848433Z] Running install step. 16:47:30 INFO - Running pre-action listener: _resource_record_pre_action 16:47:30 INFO - Running main action method: install 16:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:31 INFO - Reading from file tmpfile_stdout 16:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:31 INFO - Reading from file tmpfile_stdout 16:47:31 INFO - Output received: 16:47:31 INFO - Usage: mozinstall [options] installer 16:47:31 INFO - Options: 16:47:31 INFO - -h, --help show this help message and exit 16:47:31 INFO - -d DEST, --destination=DEST 16:47:31 INFO - Directory to install application into. [default: 16:47:31 INFO - "/builds/slave/test"] 16:47:31 INFO - --app=APP Application being installed. [default: firefox] 16:47:31 INFO - mkdir: /builds/slave/test/build/application 16:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:47:49 INFO - Reading from file tmpfile_stdout 16:47:49 INFO - Output received: 16:47:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:47:49 INFO - Running post-action listener: _resource_record_post_action 16:47:49 INFO - [mozharness: 2017-08-18 23:47:49.308279Z] Finished install step (success) 16:47:49 INFO - [mozharness: 2017-08-18 23:47:49.308559Z] Running setup-mitmproxy step. 16:47:49 INFO - Running pre-action listener: _resource_record_pre_action 16:47:49 INFO - Running main action method: setup_mitmproxy 16:47:49 INFO - Skipping: mitmproxy is not required 16:47:49 INFO - Running post-action listener: _resource_record_post_action 16:47:49 INFO - [mozharness: 2017-08-18 23:47:49.309768Z] Finished setup-mitmproxy step (success) 16:47:49 INFO - [mozharness: 2017-08-18 23:47:49.309989Z] Running run-tests step. 16:47:49 INFO - Running pre-action listener: _resource_record_pre_action 16:47:49 INFO - Running pre-action listener: _set_gcov_prefix 16:47:49 INFO - Running main action method: run_tests 16:47:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:47:49 INFO - Python 2.7.3 16:47:49 INFO - Return code: 0 16:47:49 INFO - grabbing minidump binary from tooltool 16:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x12d3130>, '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 0x12d4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d44c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:47:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:47:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:47:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:47:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:49 INFO - Return code: 0 16:47:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:47:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:47:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:47:49 INFO - ENV: RUST_BACKTRACE is now full 16:47:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:47:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:47:49 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/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:47:49 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/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:47:49 INFO - Using env: {'DISPLAY': ':0', 16:47:49 INFO - 'HOME': '/home/cltbld', 16:47:49 INFO - 'LANG': 'en_US.UTF-8', 16:47:49 INFO - 'LANGUAGE': 'en_US:en', 16:47:49 INFO - 'LOGNAME': 'cltbld', 16:47:49 INFO - 'MAIL': '/var/mail/cltbld', 16:47:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:49 INFO - 'MOZ_NO_REMOTE': '1', 16:47:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:49 INFO - 'NO_EM_RESTART': '1', 16:47:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:49 INFO - 'PWD': '/builds/slave/test', 16:47:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:49 INFO - 'RUST_BACKTRACE': 'full', 16:47:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:47:49 INFO - 'SHELL': '/bin/bash', 16:47:49 INFO - 'SHLVL': '1', 16:47:49 INFO - 'STYLO_FORCE_ENABLED': '1', 16:47:49 INFO - 'TERM': 'linux', 16:47:49 INFO - 'TMOUT': '86400', 16:47:49 INFO - 'USER': 'cltbld', 16:47:49 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848', 16:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:49 INFO - '_': '/tools/buildbot/bin/python'} 16:47:49 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/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:47:49 INFO - mozversion application_buildid: 20170818225328 16:47:49 INFO - mozversion application_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 16:47:49 INFO - mozversion application_display_name: Nightly 16:47:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:49 INFO - mozversion application_name: Firefox 16:47:49 INFO - mozversion application_remotingname: firefox 16:47:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:47:49 INFO - mozversion application_vendor: Mozilla 16:47:49 INFO - mozversion application_version: 57.0a1 16:47:49 INFO - mozversion platform_buildid: 20170818225328 16:47:49 INFO - mozversion platform_changeset: 4f4487cc2d30d988742109868dcf21c4113f12f5 16:47:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:47:49 INFO - mozversion platform_version: 57.0a1 16:47:49 INFO - using testdate: 1503100069 16:47:49 INFO - actual date: 1503100069 16:47:49 INFO - starting webserver on 'localhost:47001' 16:47:49 INFO - SUITE-START | Running 2 tests 16:47:49 INFO - TEST-START | dromaeo_css 16:47:49 INFO - Initialising browser for dromaeo_css test... 16:47:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47001/getInfo.html -profile /tmp/tmp_gLAeS/profile 16:47:49 INFO - TEST-INFO | started process 2107 (/builds/slave/test/build/application/firefox/firefox http://localhost:47001/getInfo.html) 16:47:56 INFO - TEST-INFO | 2107: exit 0 16:47:56 INFO - Browser initialized. 16:47:56 INFO - Running cycle 1/1 for dromaeo_css test... 16:47:56 INFO - TEST-INFO | started process 2294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_gLAeS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:57 INFO - PID 2294 | 16:47:57 INFO - PID 2294 | (/builds/slave/test/build/application/firefox/firefox:2343): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:47:57 INFO - PID 2294 | 16:47:57 INFO - PID 2294 | 16:47:57 INFO - PID 2294 | (/builds/slave/test/build/application/firefox/firefox:2478): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:47:57 INFO - PID 2294 | 16:47:57 INFO - PID 2294 | __metrics Screen width/height:1600/1200 16:47:57 INFO - PID 2294 | colorDepth:24 16:47:57 INFO - PID 2294 | Browser inner width/height: 1024/768 16:47:57 INFO - PID 2294 | __metrics 16:48:07 INFO - PID 2294 | RSS: Main: 174034944 16:48:07 INFO - PID 2294 | 16:51:06 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47001/tests/dromaeo/cssquery-ext.html) 16:51:07 INFO - PID 2294 | RSS: Main: 178094080 16:51:07 INFO - PID 2294 | 16:54:09 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-ext.html (next: http://localhost:47001/tests/dromaeo/cssquery-jquery.html) 16:54:10 INFO - PID 2294 | RSS: Main: 175263744 16:54:10 INFO - PID 2294 | 16:57:11 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47001/tests/dromaeo/cssquery-mootools.html) 16:57:12 INFO - PID 2294 | RSS: Main: 177012736 16:57:12 INFO - PID 2294 | 17:00:14 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47001/tests/dromaeo/cssquery-prototype.html) 17:00:14 INFO - PID 2294 | RSS: Main: 175935488 17:00:14 INFO - PID 2294 | 17:03:18 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47001/tests/dromaeo/cssquery-yui.html) 17:03:19 INFO - PID 2294 | RSS: Main: 178880512 17:03:19 INFO - PID 2294 | 17:06:20 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:47001/tests/dromaeo/cssquery-yui.html (next: http://localhost:47001/tests/dromaeo/cssquery-dojo.html) 17:06:21 INFO - PID 2294 | RSS: Main: 177053696 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | __start_tp_report 17:06:21 INFO - PID 2294 | _x_x_mozilla_page_load 17:06:21 INFO - PID 2294 | _x_x_mozilla_page_load_details 17:06:21 INFO - PID 2294 | |i|pagename|runs| 17:06:21 INFO - PID 2294 | |0;dojo.html;3137.200013996432;3167.6673949235324;3175.4919212925934;3187.4740667789815;3207.406629773492;6111.541634377417;6160.876782464354;6208.410201030906;6247.656378899159;6248.593841400306;6080.756769729217;6180.907286390697;6198.628082315065;6211.875762484748;6232.781852635158;5622.746976386073;5644.350899646532;5648.03983322834;5664.518515926151;5668.659880407189;5650.039493286151;5679.772809087653;5738.856528586798;5760.798372056979;5785.797497087603;5683.261176047129;5737.540996720252;5740.167675687023;5747.856303592423;5771.82684519463;5566.248556444909;5664.57515686321;5743.45437183471;5794.188813566083;5799.275090613694;5604.635698679614;5644.661320320753;5668.829935101953;5673.773049078032;5716.828495145152;6068.57519973602;6133.693315334215;6152;6165.599236049642;6211.782587609412;6554.475641948633;6583.967080164569;6633.20401551812;6645.900311495331;6648.102506161655;6639.435647969928;6668.86662266752;6670.966645166792;6684.966575167142;6690.364415380531;6170.444659980579;6174.135621013062;6176.567640265183;6180.907286390708;6184.628922264678;6764.5603035802515;6767.593944363354;6772.085768421299;6789.456843452512;6792.694328755218;6389.712462939179;6474.1907261592305;6536.346365363425;6617.073609694647;6622.635755033423;6654.068430419745;6681;6690.632015239208;6693.497987650946;6699.9665001674675;6536.771213007617;6539.869202615921;6560.376764207393;6636.867262654817;6649.634270115093;6562.114114594564;6585.967070164618;6615.272320044791;6627.668616569249;6677.165354330708;5474.479924407175;5486.862828429321;5487.012337779158;5488.69812160335;5489.505944465017;4692.483826779052;4693.084848454519;4697.553732395417;4703.811847526061;4717.103750287434;5723.341815691166;5787.536997040227;5796.217510636095;5800.216970708901;5801.361850196559;6688.197416310074;6693.196816381968;6703.095082163845;6703.095082163943;6725.9663701681175;5669.177969194444;5832;5843.853903652358;5877.9118313225335;5926.466618004314;5914.408559144051;5993.160957465958;6001.729922153513;6011.729472173763;6022.909656355158;6314.905276420857;6389.872202555923;6459.709313080923;6535.346465353522;6567.080608714784;6587.736490540517;6588.8352791180605;6606.537542371988;6606.933930660824;6609.339066093352;6390.712417941297;6449.871002579828;6459.418652321314;6464;6492.383223593751;6091.908621370594;6543.934560654333;6544.705488252945;6649.667516624246;6656.866862662623;6676.9666151668935;6723.630200339028;6783.796486105425;6807.89788153188;6810.557313774589;6371.585846919936;6404.391582799627;6471.741130354922;6491.578047426902;6520.347965203442;6453.451456626051;6514.446272066927;6520.18497687789;6526.086347911391;6577.6053436793945;6431;6472.611643301417;6513.316101809241;6515.348465153446;6521.673916304071;6511.772087976898;6530.738770449128;6583.341665833378;6619.371159739817;6642.634655093823;6293.150424692608;6358.554901156875;6376.872462550816;6396.584222025554;6398.808035758934 17:06:21 INFO - PID 2294 | |1;ext.html;820.6348175062096;860.5181098584791;888.6178943054488;892.4779004282494;1205.1142410328412;32176;43005;43553.78223108888;43565.78217108914;43624.56375436245;44064.55935440645;44147.558524414744;44251.557484425146;44437.55562444375;44496;7700.499467534606;7870.645820938072;7879.763607091796;7904.05151381835;7960.880586791174;7818.413618978571;7963.243491868263;7984.6007699615075;8005.6397462114055;8012.1186669466315;8015.158408367125;8060.959695201545;8075.555844428554;8077.474964127342;8077.838443231132;7943.245391687809;7979.601019948979;7980.162082981262;7991.041075071;8003.359731221488;7877.487963282369;7924.524528528307;7954.642041108106;7956.641951112156;7958.960205198995;39985;40094.39858402126;40272.597274027474;40279;40321.59678403237;3567.518385018015;3605.2068544920076;3605.4231322988194;3614.6566076222716;3625.347437461256;32324.353512929843;32361.35277294441;32451.51322730161;32487.837560812044;32556.837215814005;4760.5715485606115;4891.192953162724;4895.192293271606;4941.530554597308;4980.078685443168;193244;193579;197495;197561;199528;49296.507034929906;49351.753241233564;49504.75247623739;49552.752236238586;49555.50444495581;52025.7398713004;52031;52297;52454;52578.73710631422;14647.853521464862;14887.553373398816;15929;16697.83302166987;17034;13256.204627722367;13258.602241932758;13270.402831872396;13315.866841331657;13364.39860206293;15240.542783716506;15305.234738263041;15340.463083792014;15412.075275483507;15447.5365739028;5749.3963133871175;5935.940640593539;6041.8489537761025;6045.697715114226;6106.358832322631;984.7833476635129;1018.7911478146962;1021.5556233038503;1022.6420752736632;1024.9590016399409;22954.770452295597;23129.190478333516;23300.184493542984;23376.298711038697;23494.88252558726;1090.5801266512292;1108.6729414822646;1123.5168877382803;1123.6404350607727;1129.757102223026;12287.815682764765;12323;12334.383280835922;12401.317927514074;12410.875891240972;231488;232794;233992;234263;234303;55185.44814551803;55413.722931385084;55434.722826386416;55471;55523.72238138784;1478.3643033495484;1503.7067771784616;1510.3656464285027;1530.2960638106374;1534.9309281082378;22652.433689157904;22793.88603056974;22845.428864278525;22975.425614359774;23101.19145829888;38938;38942.61057389503;39034.80482597569;39063;39081.41377879391;193581;194109;194708;195061;195343;35167.64832351746;36110.27779444449;36785.632143678224;36845.63154368422;37095;47280.76359618318;47597;48418;48451.75774121107;48547;35044.29911401809;35158.29683406369;35177.29645407027;35232.29535409329;35428.114297142776;34995.47506787349;35008.47487287642;35044.47433288554;35204.647953520136;35511.289774203855;37866;37878;37908.241835163695;38034.429483557215;38203.617963820005;34127;34611.82694086614;34923.65076349204;34959;35057.82471087628;24579;24634.864163972627;25112;25276.46917917566;25432.364190895376 17:06:21 INFO - PID 2294 | |2;jquery.html;537.784886045582;559.4098226371182;565.1268789719883;566.575068698476;590.5688847141586;21215.57568848622;21777.3466795996;21823.67264491034;21851.344459666198;21876.671849922262;24275.878620606873;26280.211593652173;26288.605670914905;26380;26424.339391515223;6520.119783829182;6646.26891041985;6651.933480665204;6664.4668426526005;6679.265280819106;5711.9718450678865;5747.540196784268;5850.970745146268;6371.26730426;6393.4885209183385;6365.458935990447;6372.93627063728;6377.298497165308;6392;6393.680315984206;6327.588706734047;6344.365563443642;6348.206474190726;6358;6376.458001069915;5896;5916.615419997729;5935.347111817697;5943.286805583314;5951.851203719898;29074.127776166748;29808.552871706943;30298.394032119235;30725.078247652607;31047;1964.2143142742875;2007.5483016321357;2010.788867168941;2014.0433294185145;2018.2835093541728;19114.13986370617;19703.704444433344;19787.109580068933;19791.604167916707;19874.3043993461;2196.9231076912392;2218.389942765736;2262.2986874069093;2266.8866556672265;2270.4664403865077;131963;137761;137909;138337;138360.30819845837;14436.123303970417;14603.342849571794;14829.18439485817;14862.331195096247;15124.168170750494;23670.64494032591;23678.4080397988;23700.88149559241;23733.288001359986;23757.287281381585;10158.746031349276;10266.589336426608;10289.382637041801;10350;10438.217133715001;9482.288828337765;9505.524723763923;9540;9561.952190239004;9668.129868311886;7912.744867712674;9218.400803947721;9294.163525282756;9427.15155635996;9452.52737363129;2805.2566069991467;2813.957790633142;2856.6714827794654;2860.7425331720247;2941.6175897133235;972.2367941166151;980.0836218136066;986.0386123529645;986.8766404199475;998.3959704378747;19935.302264420676;19993.400197994084;20224.898875505824;20392.28626998048;20563;998.9250806189565;1061.867266591676;1064.2337516987911;1065.158524765442;1080.3841810168285;10857.294275872044;11200.887991119984;11289.49197286124;11343.092552595772;11386.202965792316;510746;520291;521145;527233;527824;115432.42283788696;117896.41051794686;118522;122194.38902805607;122324.38837805754;1304.7260075384086;1326.4561529772748;1326.973460530784;1329.7207586406962;1337.0239725000804;17835.643287134444;17879.10604469797;17926;17999;18054.097295135452;53462;53862.19206711824;55345.44654553403;55938;56402;72410;72582.63708681634;72702.63648681722;72723;73165.6341718288;12484.250944943333;13162.552119266682;14416.495422660157;14803.851961480248;15186.46847360337;23179;23362.532749344577;23389.649155262345;24804.255872323858;24913.377165571004;19159.8084019158;19278.903605481883;19293.421197364103;19449.222031118596;19504.707429388855;16777.245023973708;17305.56736081608;17403.042832644325;17674.469765907044;18007;18853.811461885205;19516.414507564798;19630.116644751306;19806.603867922848;19812.90093549523;14661.193634350213;14857.554273371816;14960.476383326532;14963.40146394132;14997.625059373166;18338.358157464423;18560.071996400395;18718.812811871707;18733.90633046826;18758.53103672419 17:06:21 INFO - PID 2294 | |3;mootools.html;1384.0934188106787;1430.4421275702477;1438.661914450104;1447.225734232186;1449.9999999999998;13920.234387108705;14000.229987350716;14602.19687917164;14646.121232726044;14652.194129322883;14538.781918271234;14756;14760.630984225372;14770.335334909929;14784.926075369634;2700.054980756734;2728.5088684036864;2730.57676060211;2735.1657744387953;2735.384538478846;2619.358257226982;2626.93432664183;2664.6136310235006;2680.32991752062;2680.437108207279;2614.6078088286718;2641.630171775953;2684.7852171826303;2723.8774255158564;2729.877155527996;2645.31221882311;2648.6821581410354;2652.456246469469;2660.7472290132405;2661.42779302449;2565.9230223093336;2580.135654555726;2585.650937123483;2588.741125887415;2588.8835002424935;13691.589252322447;13927.651808704763;13930.721385572231;13939.442422303096;13951.302434878215;7671.079470463525;7879.290863822283;7922.920770792276;7926.167752385974;7926.8810967835525;4988.575971042465;5086.618503612207;5130.846074617767;5207.375114986188;5209.765560549784;1810.2939853457162;1811.1345314326265;1811.9219064656509;1843.75109360236;1857.8606604504716;22861.31416057521;23054.193103241305;23058.847057647217;23082.192123275774;23130.537389252288;6346.524010699216;6416.839579010562;6488.610683359014;6490.8052758417325;6714.899276510856;16034.75947860783;16045.759313610306;16216;16608.169591520375;16654.250558724885;7527;7776.65005074773;7786.221377862282;7805.765827025199;7826.921730782733;7163.820904477429;7214.531055481482;7262.6731797068205;7295.416366690652;7329.19378868324;4965.255211718271;5150.124478838607;5177.611679124081;5181.549166233461;5182.714950677673;1506.7212565675386;1527.1447989125902;1527.3585094260438;1539.1842323568526;1547.4506550174751;907.981840363189;937.929655275857;940.7318914109583;941.5715849288557;949.6818565780403;7593;7628.69485220596;7632.961835190788;7658;7712.460127791001;706.6537396675592;719.6977269546699;725.5392825555705;725.9528130671489;735.4594373135741;4572.513932971731;4639.9536004640195;5205.895882082337;5330.866728331823;5394.78420863161;19241.51896202578;20141.697874531892;20148.697769533468;20481.692774608393;20501.077451514717;18738.437846864617;19573.412797616093;19590.608187836162;19701.84711055201;19834.60330793405;11072.058874995715;11146.386948717736;11170.27393219438;11211.439428028565;11219.831702524469;7639.350655194148;8041.798955025937;8615.439996400213;8741.169588889044;8776.517291549026;16475.58811029734;16901.577460563094;17003.7449438261;17006.914965425094;17669.204885779913;16920.74618880693;17440.47678569645;17643.558911026812;17844.464666060037;17954.281828726704;13195.076344655781;13243.933780331423;13486.12340197884;13489.595312140651;13494.595162145151;13388.464461421823;13508.932455337661;13590.796138058135;13600.523981660594;13608;10848.728781780519;10857.185711071543;10905.563777448813;10928.344299342065;11076.944615277194;10293.073623373932;10702.946485267525;10763.300385474919;10773.569057237935;10936.671899843017;9434.622615095319;9497.525123743924;9504.857427138737;9585.712428627152;9603.951980240334;6945.826354340979;6965.407940324926;7015.543989640657;7079.610621415665;7218.855622887408;7307.159676637042;7328.157261914735;7385.8153546161775;7411.370033547209;7523 17:06:21 INFO - PID 2294 | |4;prototype.html;503.3959248901317;505.9190529515277;531.1475082492599;538.5906710899715;541.610040770645;6264.154339164212;6353.205849268841;6370.17187765591;6442.742290308393;6445.291017988017;6071.939280607193;6146.784862529812;6194.59735117217;6239;6264.749410023605;4923.261510773395;5033.546980771748;5049.712323357548;5063.316452278932;5075.467075957026;4956.479569645189;5071.315372424712;5073.137566613685;5074.391073071218;5114.2072978688175;4808.158572249859;4915.434725006634;4954.810845397097;4982.5764809991015;5030.195168772997;4864.8540543783565;4924.285978533128;4932.482089380599;5005.2492126181;5007.674501157413;4465.307877278994;4473.865784026484;4496.505384407713;4498.955010449887;4509.977450112761;6127.4791642710425;6151.200343955302;6153.692315384257;6177.042558403455;6191.535634827406;5709.288088158133;5741.081426971707;5770.855728606818;5771.884562308773;5784.3926387729525;6526.771562995273;6528.51036172289;6617.172853393326;6620.503462240351;6635.568688035262;4858.271259311132;4875.488073752276;4887.315775791392;4916.680415772999;4927.211646136637;6799.218089919673;6872.244053154149;6894.724211031553;6935.653217339112;7013.82465438363;4980.601551875841;4990.902001559651;5041.470645582234;5057.848264552069;5060.84817455477;5073.137566613685;5133.435322114565;5133.486651334912;5134.71632091977;5158.039944821019;5610.887782244332;5633.155026745939;5727.224560386294;5778.27771528559;5815.941840581625;6500.967495162494;6567.802965911031;6570.8028759137305;6602.2407423146;6621.9006714899315;1674.8325167483397;1696.787901512311;1732.9306827727003;1747.5106970048153;1778.1287169287216;1193.5345215366015;1227.2636418149038;1228.177121328712;1230.5569994801865;1249.8875101240933;5768.942310576925;5781.508571771363;5831.591788574759;5832.533397328203;5839.970800146057;6575.914974029327;6649.434798042221;6716.697748601325;6770.932290677129;6785.423239024738;5847.239858818411;5870.148828419855;5890.293164820249;5909;5911.822645320647;3514.9824250878582;3587.497750314958;3591.8204089795404;3603.8647825934745;3626.1841085755495;6609.537332386687;6624.735010599618;6634;6687.531872768859;6693.330666933268;6869.793906182823;6919.37725604698;6991.475639327071;6992.475564332695;6996.6851491683;6549.345065493412;6560.868782624225;6586.967065164739;6612.107365505595;6626.370494802986;6853.520253582401;6854.760083397057;6865.347791959756;6874.450043996369;6904.896426553706;6770.966145169243;6782.186137663314;6807.413182990432;6814.693338799667;6817.454603631797;6644.833879152867;6665.733370665119;6666.83332916681;6669.933300666931;6706.429953454011;4991.401031876198;5043.142665746906;5043.470435604208;5073.695578265316;5074.4120498546745;6807;6842.726290948306;6860.965695171492;6904.447644188554;6955.513114081966;6606.933930660632;6611.140551728245;6620.8344791380605;6646.136002319668;6707.295733947865;6328.557001009885;6500.739970401131;6589.242237142598;6720.8319792005595;6757.222919364336;6376.171097757262;6497.902531462127;6507.479401647952;6534.281229064704;6570.5729127606555;6661.4004739573675;6661.966690166518;6662.766803161866;6664.866702665822;6674.566153200027;6328.841993775059;6361.936380636134;6406.87186256263;6437.549371543947;6453.677316134081 17:06:21 INFO - PID 2294 | |5;yui.html;912.9269658427326;915.3272344826555;938.1744065222603;940.8071345374199;943.2312665177877;19134.904325478372;19757.110930008148;19950.90024549877;19983.800161998377;22777.886110569467;19302.90348548255;19316.71024934627;19732.408027759153;19839.305624303153;20019.799802001977;794.3764145146062;800.6237068577789;1046.4819914142472;1051.1223128687516;1055.4036969112465;1070.70555597211;1075.295681328731;1075.779465209634;1075.8386242063675;1076.2358725305044;1117.5250518529633;1118.9720256993598;1119.0096764363516;1121.9831702524468;1122.84841546391;1117.3631030312683;1119.160629527854;1122.5790328626765;1125.656674714212;1127.222216670503;813.4915677701437;817.4441379861692;818.7216346442239;819.2544784246367;823.7611092783086;19252.32616858417;19859.30492432758;19911.90044049785;19989.200431982703;20109.09509072095;21306.041228144615;21614.783852161436;21736.891315543322;22233.44416389587;22264.666030009565;15109.773353399707;15136.54590362291;15182.772258416133;15240;15271.618209544738;3529.75291729579;3553.271579326258;3557.7331700122336;3558.4128618777872;3558.5907620623702;122144;126032.36983815113;128549.35725321407;128737.35631321877;129317;17724.91137544304;18107.637847243244;18194.90902545479;18341;18546;32299;32545.34909301801;32623.836880815918;32655.346893062007;32833.671663283065;7545.660445279866;9052.411593246417;9126.58930348136;9141.085891410805;9155.725328240163;4021.4168945503325;4161.812718427678;4168.124693814333;4173.791310434466;4202.873913782591;5038.143515602356;5137;5151.25306830515;5154.8969020620125;5165.509276618715;987.9357841740264;988.9752756181009;1001.8797744270735;1002.9097381235724;1006.9647562335283;685.7908337956871;707.7664370757637;715.1382583986388;723.5586292361655;737.9631018449056;12051;12212.206206596542;12591.748165036648;13090.803637945439;13524;695.6799872058909;699.6152116335995;700.1493185779302;711.0791524975169;717.2683862460261;5607.383187849333;6040.335563088057;6295.338989406138;6554.279029306773;6715.630640314829;108587;108889;111423.44288278506;112104.4394778021;118094;95760.52119739496;101572.49213753884;103541.48229258956;104696;109061.45469272602;86790;87084;88312.55843720741;90267.54866225627;90298.09701903028;12005.279683219034;12158.270503769449;12198.939005304917;12387.876121238673;12547.306113674536;37821.243575128894;38363;38563.421548677354;39232.80383598064;40389;49333.753331233114;50386.49613503965;50730.2390464136;51514.74242628763;52290;18684.626307473503;19209.711854322475;19225.807741922403;19797.802021979594;19818;21922.561548769256;22225.555488890455;22332.21837235689;22764;22976;19666.311679091163;19734.901325493855;19963.301284455556;20253.18987240494;20392.694109588665;17444.91277543604;18126.18432170582;18157.909210453865;18229.726554101966;18241.270349185885;17599.472015839547;18025.549361266072;18548.814511854707;19154.425367239004;19438.222471101;13420.865791342352;13438.798418023542;13545.796813047615;13780.586582402544;13802.447902084206;15098.849011509745;15223.865730364882;15326.770098448309;15368.462103826312;15392.230388480755 17:06:21 INFO - PID 2294 | __end_tp_report 17:06:21 INFO - PID 2294 | __start_cc_report 17:06:21 INFO - PID 2294 | _x_x_mozilla_cycle_collect,379 17:06:21 INFO - PID 2294 | __end_cc_report 17:06:21 INFO - PID 2294 | __startTimestamp1503101181187__endTimestamp 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | ------- Summary: start ------- 17:06:21 INFO - PID 2294 | Number of tests: 6 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#0] dojo.html Cycles:165 Average:6135.94 Median:6389.87 stddev:704.18 (11.0%) stddev-sans-first:665.89 17:06:21 INFO - PID 2294 | Values: 3137.2 3167.7 3175.5 3187.5 3207.4 6111.5 6160.9 6208.4 6247.7 6248.6 6080.8 6180.9 6198.6 6211.9 6232.8 5622.7 5644.4 5648.0 5664.5 5668.7 5650.0 5679.8 5738.9 5760.8 5785.8 5683.3 5737.5 5740.2 5747.9 5771.8 5566.2 5664.6 5743.5 5794.2 5799.3 5604.6 5644.7 5668.8 5673.8 5716.8 6068.6 6133.7 6152.0 6165.6 6211.8 6554.5 6584.0 6633.2 6645.9 6648.1 6639.4 6668.9 6671.0 6685.0 6690.4 6170.4 6174.1 6176.6 6180.9 6184.6 6764.6 6767.6 6772.1 6789.5 6792.7 6389.7 6474.2 6536.3 6617.1 6622.6 6654.1 6681.0 6690.6 6693.5 6700.0 6536.8 6539.9 6560.4 6636.9 6649.6 6562.1 6586.0 6615.3 6627.7 6677.2 5474.5 5486.9 5487.0 5488.7 5489.5 4692.5 4693.1 4697.6 4703.8 4717.1 5723.3 5787.5 5796.2 5800.2 5801.4 6688.2 6693.2 6703.1 6703.1 6726.0 5669.2 5832.0 5843.9 5877.9 5926.5 5914.4 5993.2 6001.7 6011.7 6022.9 6314.9 6389.9 6459.7 6535.3 6567.1 6587.7 6588.8 6606.5 6606.9 6609.3 6390.7 6449.9 6459.4 6464.0 6492.4 6091.9 6543.9 6544.7 6649.7 6656.9 6677.0 6723.6 6783.8 6807.9 6810.6 6371.6 6404.4 6471.7 6491.6 6520.3 6453.5 6514.4 6520.2 6526.1 6577.6 6431.0 6472.6 6513.3 6515.3 6521.7 6511.8 6530.7 6583.3 6619.4 6642.6 6293.2 6358.6 6376.9 6396.6 6398.8 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#1] ext.html Cycles:180 Average:38688.64 Median:19862.47 stddev:54089.43 (272.3%) stddev-sans-first:54166.43 17:06:21 INFO - PID 2294 | Values: 820.6 860.5 888.6 892.5 1205.1 32176.0 43005.0 43553.8 43565.8 43624.6 44064.6 44147.6 44251.6 44437.6 44496.0 7700.5 7870.6 7879.8 7904.1 7960.9 7818.4 7963.2 7984.6 8005.6 8012.1 8015.2 8061.0 8075.6 8077.5 8077.8 7943.2 7979.6 7980.2 7991.0 8003.4 7877.5 7924.5 7954.6 7956.6 7959.0 39985.0 40094.4 40272.6 40279.0 40321.6 3567.5 3605.2 3605.4 3614.7 3625.3 32324.4 32361.4 32451.5 32487.8 32556.8 4760.6 4891.2 4895.2 4941.5 4980.1 193244.0 193579.0 197495.0 197561.0 199528.0 49296.5 49351.8 49504.8 49552.8 49555.5 52025.7 52031.0 52297.0 52454.0 52578.7 14647.9 14887.6 15929.0 16697.8 17034.0 13256.2 13258.6 13270.4 13315.9 13364.4 15240.5 15305.2 15340.5 15412.1 15447.5 5749.4 5935.9 6041.8 6045.7 6106.4 984.8 1018.8 1021.6 1022.6 1025.0 22954.8 23129.2 23300.2 23376.3 23494.9 1090.6 1108.7 1123.5 1123.6 1129.8 12287.8 12323.0 12334.4 12401.3 12410.9 231488.0 232794.0 233992.0 234263.0 234303.0 55185.4 55413.7 55434.7 55471.0 55523.7 1478.4 1503.7 1510.4 1530.3 1534.9 22652.4 22793.9 22845.4 22975.4 23101.2 38938.0 38942.6 39034.8 39063.0 39081.4 193581.0 194109.0 194708.0 195061.0 195343.0 35167.6 36110.3 36785.6 36845.6 37095.0 47280.8 47597.0 48418.0 48451.8 48547.0 35044.3 35158.3 35177.3 35232.3 35428.1 34995.5 35008.5 35044.5 35204.6 35511.3 37866.0 37878.0 37908.2 38034.4 38203.6 34127.0 34611.8 34923.7 34959.0 35057.8 24579.0 24634.9 25112.0 25276.5 25432.4 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#2] jquery.html Cycles:180 Average:35823.33 Median:2240.34 stddev:87486.35 (3905.0%) stddev-sans-first:87691.65 17:06:21 INFO - PID 2294 | Values: 537.8 559.4 565.1 566.6 590.6 21215.6 21777.3 21823.7 21851.3 21876.7 24275.9 26280.2 26288.6 26380.0 26424.3 6520.1 6646.3 6651.9 6664.5 6679.3 5712.0 5747.5 5851.0 6371.3 6393.5 6365.5 6372.9 6377.3 6392.0 6393.7 6327.6 6344.4 6348.2 6358.0 6376.5 5896.0 5916.6 5935.3 5943.3 5951.9 29074.1 29808.6 30298.4 30725.1 31047.0 1964.2 2007.5 2010.8 2014.0 2018.3 19114.1 19703.7 19787.1 19791.6 19874.3 2196.9 2218.4 2262.3 2266.9 2270.5 131963.0 137761.0 137909.0 138337.0 138360.3 14436.1 14603.3 14829.2 14862.3 15124.2 23670.6 23678.4 23700.9 23733.3 23757.3 10158.7 10266.6 10289.4 10350.0 10438.2 9482.3 9505.5 9540.0 9562.0 9668.1 7912.7 9218.4 9294.2 9427.2 9452.5 2805.3 2814.0 2856.7 2860.7 2941.6 972.2 980.1 986.0 986.9 998.4 19935.3 19993.4 20224.9 20392.3 20563.0 998.9 1061.9 1064.2 1065.2 1080.4 10857.3 11200.9 11289.5 11343.1 11386.2 510746.0 520291.0 521145.0 527233.0 527824.0 115432.4 117896.4 118522.0 122194.4 122324.4 1304.7 1326.5 1327.0 1329.7 1337.0 17835.6 17879.1 17926.0 17999.0 18054.1 53462.0 53862.2 55345.4 55938.0 56402.0 72410.0 72582.6 72702.6 72723.0 73165.6 12484.3 13162.6 14416.5 14803.9 15186.5 23179.0 23362.5 23389.6 24804.3 24913.4 19159.8 19278.9 19293.4 19449.2 19504.7 16777.2 17305.6 17403.0 17674.5 18007.0 18853.8 19516.4 19630.1 19806.6 19812.9 14661.2 14857.6 14960.5 14963.4 14997.6 18338.4 18560.1 18718.8 18733.9 18758.5 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#3] mootools.html Cycles:180 Average:8903.82 Median:2616.98 stddev:6083.16 (232.4%) stddev-sans-first:6073.98 17:06:21 INFO - PID 2294 | Values: 1384.1 1430.4 1438.7 1447.2 1450.0 13920.2 14000.2 14602.2 14646.1 14652.2 14538.8 14756.0 14760.6 14770.3 14784.9 2700.1 2728.5 2730.6 2735.2 2735.4 2619.4 2626.9 2664.6 2680.3 2680.4 2614.6 2641.6 2684.8 2723.9 2729.9 2645.3 2648.7 2652.5 2660.7 2661.4 2565.9 2580.1 2585.7 2588.7 2588.9 13691.6 13927.7 13930.7 13939.4 13951.3 7671.1 7879.3 7922.9 7926.2 7926.9 4988.6 5086.6 5130.8 5207.4 5209.8 1810.3 1811.1 1811.9 1843.8 1857.9 22861.3 23054.2 23058.8 23082.2 23130.5 6346.5 6416.8 6488.6 6490.8 6714.9 16034.8 16045.8 16216.0 16608.2 16654.3 7527.0 7776.7 7786.2 7805.8 7826.9 7163.8 7214.5 7262.7 7295.4 7329.2 4965.3 5150.1 5177.6 5181.5 5182.7 1506.7 1527.1 1527.4 1539.2 1547.5 908.0 937.9 940.7 941.6 949.7 7593.0 7628.7 7633.0 7658.0 7712.5 706.7 719.7 725.5 726.0 735.5 4572.5 4640.0 5205.9 5330.9 5394.8 19241.5 20141.7 20148.7 20481.7 20501.1 18738.4 19573.4 19590.6 19701.8 19834.6 11072.1 11146.4 11170.3 11211.4 11219.8 7639.4 8041.8 8615.4 8741.2 8776.5 16475.6 16901.6 17003.7 17006.9 17669.2 16920.7 17440.5 17643.6 17844.5 17954.3 13195.1 13243.9 13486.1 13489.6 13494.6 13388.5 13508.9 13590.8 13600.5 13608.0 10848.7 10857.2 10905.6 10928.3 11076.9 10293.1 10702.9 10763.3 10773.6 10936.7 9434.6 9497.5 9504.9 9585.7 9604.0 6945.8 6965.4 7015.5 7079.6 7218.9 7307.2 7328.2 7385.8 7411.4 7523.0 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#4] prototype.html Cycles:180 Average:5567.81 Median:6184.29 stddev:1573.97 (25.5%) stddev-sans-first:1531.80 17:06:21 INFO - PID 2294 | Values: 503.4 505.9 531.1 538.6 541.6 6264.2 6353.2 6370.2 6442.7 6445.3 6071.9 6146.8 6194.6 6239.0 6264.7 4923.3 5033.5 5049.7 5063.3 5075.5 4956.5 5071.3 5073.1 5074.4 5114.2 4808.2 4915.4 4954.8 4982.6 5030.2 4864.9 4924.3 4932.5 5005.2 5007.7 4465.3 4473.9 4496.5 4499.0 4510.0 6127.5 6151.2 6153.7 6177.0 6191.5 5709.3 5741.1 5770.9 5771.9 5784.4 6526.8 6528.5 6617.2 6620.5 6635.6 4858.3 4875.5 4887.3 4916.7 4927.2 6799.2 6872.2 6894.7 6935.7 7013.8 4980.6 4990.9 5041.5 5057.8 5060.8 5073.1 5133.4 5133.5 5134.7 5158.0 5610.9 5633.2 5727.2 5778.3 5815.9 6501.0 6567.8 6570.8 6602.2 6621.9 1674.8 1696.8 1732.9 1747.5 1778.1 1193.5 1227.3 1228.2 1230.6 1249.9 5768.9 5781.5 5831.6 5832.5 5840.0 6575.9 6649.4 6716.7 6770.9 6785.4 5847.2 5870.1 5890.3 5909.0 5911.8 3515.0 3587.5 3591.8 3603.9 3626.2 6609.5 6624.7 6634.0 6687.5 6693.3 6869.8 6919.4 6991.5 6992.5 6996.7 6549.3 6560.9 6587.0 6612.1 6626.4 6853.5 6854.8 6865.3 6874.5 6904.9 6771.0 6782.2 6807.4 6814.7 6817.5 6644.8 6665.7 6666.8 6669.9 6706.4 4991.4 5043.1 5043.5 5073.7 5074.4 6807.0 6842.7 6861.0 6904.4 6955.5 6606.9 6611.1 6620.8 6646.1 6707.3 6328.6 6500.7 6589.2 6720.8 6757.2 6376.2 6497.9 6507.5 6534.3 6570.6 6661.4 6662.0 6662.8 6664.9 6674.6 6328.8 6361.9 6406.9 6437.5 6453.7 17:06:21 INFO - PID 2294 | 17:06:21 INFO - PID 2294 | [#5] yui.html Cycles:180 Average:23780.10 Median:19931.40 stddev:32144.74 (161.3%) stddev-sans-first:32189.05 17:06:21 INFO - PID 2294 | Values: 912.9 915.3 938.2 940.8 943.2 19134.9 19757.1 19950.9 19983.8 22777.9 19302.9 19316.7 19732.4 19839.3 20019.8 794.4 800.6 1046.5 1051.1 1055.4 1070.7 1075.3 1075.8 1075.8 1076.2 1117.5 1119.0 1119.0 1122.0 1122.8 1117.4 1119.2 1122.6 1125.7 1127.2 813.5 817.4 818.7 819.3 823.8 19252.3 19859.3 19911.9 19989.2 20109.1 21306.0 21614.8 21736.9 22233.4 22264.7 15109.8 15136.5 15182.8 15240.0 15271.6 3529.8 3553.3 3557.7 3558.4 3558.6 122144.0 126032.4 128549.4 128737.4 129317.0 17724.9 18107.6 18194.9 18341.0 18546.0 32299.0 32545.3 32623.8 32655.3 32833.7 7545.7 9052.4 9126.6 9141.1 9155.7 4021.4 4161.8 4168.1 4173.8 4202.9 5038.1 5137.0 5151.3 5154.9 5165.5 987.9 989.0 1001.9 1002.9 1007.0 685.8 707.8 715.1 723.6 738.0 12051.0 12212.2 12591.7 13090.8 13524.0 695.7 699.6 700.1 711.1 717.3 5607.4 6040.3 6295.3 6554.3 6715.6 108587.0 108889.0 111423.4 112104.4 118094.0 95760.5 101572.5 103541.5 104696.0 109061.5 86790.0 87084.0 88312.6 90267.5 90298.1 12005.3 12158.3 12198.9 12387.9 12547.3 37821.2 38363.0 38563.4 39232.8 40389.0 49333.8 50386.5 50730.2 51514.7 52290.0 18684.6 19209.7 19225.8 19797.8 19818.0 21922.6 22225.6 22332.2 22764.0 22976.0 19666.3 19734.9 19963.3 20253.2 20392.7 17444.9 18126.2 18157.9 18229.7 18241.3 17599.5 18025.5 18548.8 19154.4 19438.2 13420.9 13438.8 13545.8 13780.6 13802.4 15098.8 15223.9 15326.8 15368.5 15392.2 17:06:21 INFO - PID 2294 | -------- Summary: end -------- 17:06:21 INFO - PID 2294 | 17:06:21 INFO - TEST-INFO | 2294: exit 0 17:06:21 INFO - TEST-OK | dromaeo_css | took 1112294ms 17:06:21 INFO - TEST-START | kraken 17:06:21 INFO - Initialising browser for kraken test... 17:06:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47001/getInfo.html -profile /tmp/tmpppKKao/profile 17:06:21 INFO - TEST-INFO | started process 2881 (/builds/slave/test/build/application/firefox/firefox http://localhost:47001/getInfo.html) 17:06:28 INFO - TEST-INFO | 2881: exit 0 17:06:28 INFO - Browser initialized. 17:06:28 INFO - Running cycle 1/1 for kraken test... 17:06:28 INFO - TEST-INFO | started process 3091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppKKao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:29 INFO - PID 3091 | 17:06:29 INFO - PID 3091 | (/builds/slave/test/build/application/firefox/firefox:3141): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:06:29 INFO - PID 3091 | 17:06:29 INFO - PID 3091 | 17:06:29 INFO - PID 3091 | (/builds/slave/test/build/application/firefox/firefox:3203): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:06:29 INFO - PID 3091 | 17:06:30 INFO - PID 3091 | __metrics Screen width/height:1600/1200 17:06:30 INFO - PID 3091 | colorDepth:24 17:06:30 INFO - PID 3091 | Browser inner width/height: 1024/768 17:06:30 INFO - PID 3091 | __metrics 17:06:39 INFO - PID 3091 | RSS: Main: 174419968 17:06:39 INFO - PID 3091 | 17:06:42 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47001/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:43 INFO - PID 3091 | RSS: Main: 178487296 17:06:43 INFO - PID 3091 | 17:06:46 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47001/tests/kraken/driver.html?testName=audio-dft) 17:06:46 INFO - PID 3091 | RSS: Main: 178622464 17:06:46 INFO - PID 3091 | 17:06:49 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47001/tests/kraken/driver.html?testName=audio-fft) 17:06:50 INFO - PID 3091 | RSS: Main: 173543424 17:06:50 INFO - PID 3091 | 17:06:52 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47001/tests/kraken/driver.html?testName=audio-oscillator) 17:06:53 INFO - PID 3091 | RSS: Main: 174858240 17:06:53 INFO - PID 3091 | 17:06:55 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:06:56 INFO - PID 3091 | RSS: Main: 174534656 17:06:56 INFO - PID 3091 | 17:06:59 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47001/tests/kraken/driver.html?testName=imaging-darkroom) 17:06:59 INFO - PID 3091 | RSS: Main: 175587328 17:06:59 INFO - PID 3091 | 17:07:03 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47001/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:04 INFO - PID 3091 | RSS: Main: 175308800 17:07:04 INFO - PID 3091 | 17:07:06 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47001/tests/kraken/driver.html?testName=json-parse-financial) 17:07:07 INFO - PID 3091 | RSS: Main: 175472640 17:07:07 INFO - PID 3091 | 17:07:09 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:09 INFO - PID 3091 | RSS: Main: 175636480 17:07:09 INFO - PID 3091 | 17:07:11 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:12 INFO - PID 3091 | RSS: Main: 175984640 17:07:12 INFO - PID 3091 | 17:07:14 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:15 INFO - PID 3091 | RSS: Main: 175824896 17:07:15 INFO - PID 3091 | 17:07:17 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:18 INFO - PID 3091 | RSS: Main: 176353280 17:07:18 INFO - PID 3091 | 17:07:21 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:22 INFO - PID 3091 | RSS: Main: 176353280 17:07:22 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | Cycle 1(1): loaded http://localhost:47001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47001/tests/kraken/driver.html?testName=ai-astar) 17:07:24 INFO - PID 3091 | RSS: Main: 178012160 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | __start_tp_report 17:07:24 INFO - PID 3091 | _x_x_mozilla_page_load 17:07:24 INFO - PID 3091 | _x_x_mozilla_page_load_details 17:07:24 INFO - PID 3091 | |i|pagename|runs| 17:07:24 INFO - PID 3091 | |0;ai-astar;99;107;103;113;119;114;108;103;108;109 17:07:24 INFO - PID 3091 | |1;audio-beat-detection;141;119;162;180;115;140;146;120;171;119 17:07:24 INFO - PID 3091 | |2;audio-dft;164;165;163;161;162;165;168;167;163;164 17:07:24 INFO - PID 3091 | |3;audio-fft;74;75;75;172;82;76;74;82;162;80 17:07:24 INFO - PID 3091 | |4;audio-oscillator;79;81;136;78;79;78;137;79;79;130 17:07:24 INFO - PID 3091 | |5;imaging-gaussian-blur;114;116;116;117;114;114;114;120;115;113 17:07:24 INFO - PID 3091 | |6;imaging-darkroom;150;154;156;151;152;150;153;151;152;153 17:07:24 INFO - PID 3091 | |7;imaging-desaturate;99;99;94;94;94;94;94;94;94;94 17:07:24 INFO - PID 3091 | |8;json-parse-financial;53;57;55;53;55;54;54;57;58;56 17:07:24 INFO - PID 3091 | |9;json-stringify-tinderbox;59;58;58;59;55;57;63;55;55;54 17:07:24 INFO - PID 3091 | |10;stanford-crypto-aes;77;79;75;76;75;75;75;86;79;75 17:07:24 INFO - PID 3091 | |11;stanford-crypto-ccm;127;123;132;121;117;126;120;123;120;192 17:07:24 INFO - PID 3091 | |12;stanford-crypto-pbkdf2;171;170;178;172;172;169;171;170;167;174 17:07:24 INFO - PID 3091 | |13;stanford-crypto-sha256-iterative;70;68;74;72;70;69;67;69;66;67 17:07:24 INFO - PID 3091 | __end_tp_report 17:07:24 INFO - PID 3091 | __start_cc_report 17:07:24 INFO - PID 3091 | _x_x_mozilla_cycle_collect,967 17:07:24 INFO - PID 3091 | __end_cc_report 17:07:24 INFO - PID 3091 | __startTimestamp1503101244396__endTimestamp 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | ------- Summary: start ------- 17:07:24 INFO - PID 3091 | Number of tests: 14 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#0] ai-astar Cycles:10 Average:108.30 Median:111.00 stddev:5.91 (5.3%) stddev-sans-first:5.22 17:07:24 INFO - PID 3091 | Values: 99.0 107.0 103.0 113.0 119.0 114.0 108.0 103.0 108.0 109.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:143.50 stddev:23.50 (16.4%) stddev-sans-first:24.93 17:07:24 INFO - PID 3091 | Values: 141.0 119.0 162.0 180.0 115.0 140.0 146.0 120.0 171.0 119.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:2.15 (1.3%) stddev-sans-first:2.28 17:07:24 INFO - PID 3091 | Values: 164.0 165.0 163.0 161.0 162.0 165.0 168.0 167.0 163.0 164.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:38.04 (50.4%) stddev-sans-first:39.57 17:07:24 INFO - PID 3091 | Values: 74.0 75.0 75.0 172.0 82.0 76.0 74.0 82.0 162.0 80.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:79.00 stddev:26.80 (33.9%) stddev-sans-first:27.74 17:07:24 INFO - PID 3091 | Values: 79.0 81.0 136.0 78.0 79.0 78.0 137.0 79.0 79.0 130.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.50 stddev:2.06 (1.8%) stddev-sans-first:2.13 17:07:24 INFO - PID 3091 | Values: 114.0 116.0 116.0 117.0 114.0 114.0 114.0 120.0 115.0 113.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.50 stddev:1.87 (1.2%) stddev-sans-first:1.81 17:07:24 INFO - PID 3091 | Values: 150.0 154.0 156.0 151.0 152.0 150.0 153.0 151.0 152.0 153.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.11 (2.2%) stddev-sans-first:1.67 17:07:24 INFO - PID 3091 | Values: 99.0 99.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.75 (3.2%) stddev-sans-first:1.67 17:07:24 INFO - PID 3091 | Values: 53.0 57.0 55.0 53.0 55.0 54.0 54.0 57.0 58.0 56.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:58.00 stddev:2.71 (4.7%) stddev-sans-first:2.80 17:07:24 INFO - PID 3091 | Values: 59.0 58.0 58.0 59.0 55.0 57.0 63.0 55.0 55.0 54.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:3.49 (4.6%) stddev-sans-first:3.70 17:07:24 INFO - PID 3091 | Values: 77.0 79.0 75.0 76.0 75.0 75.0 75.0 86.0 79.0 75.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:124.50 stddev:22.16 (17.8%) stddev-sans-first:23.48 17:07:24 INFO - PID 3091 | Values: 127.0 123.0 132.0 121.0 117.0 126.0 120.0 123.0 120.0 192.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:2.99 (1.7%) stddev-sans-first:3.17 17:07:24 INFO - PID 3091 | Values: 171.0 170.0 178.0 172.0 172.0 169.0 171.0 170.0 167.0 174.0 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.44 (3.5%) stddev-sans-first:2.57 17:07:24 INFO - PID 3091 | Values: 70.0 68.0 74.0 72.0 70.0 69.0 67.0 69.0 66.0 67.0 17:07:24 INFO - PID 3091 | -------- Summary: end -------- 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:07:24 INFO - PID 3091 | 17:07:24 INFO - PID 3091 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:07:25 INFO - TEST-INFO | 3091: exit 0 17:07:25 INFO - TEST-OK | kraken | took 63229ms 17:07:25 INFO - SUITE-END | took 1175s 17:07:25 INFO - Completed test suite (00:19:35) 17:07:25 INFO - javascript benchmark 17:07:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8580.32996175417, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.200013996432, 3167.6673949235324, 3175.4919212925934, 3187.4740667789815, 3207.406629773492, 6111.541634377417, 6160.876782464354, 6208.410201030906, 6247.656378899159, 6248.593841400306, 6080.756769729217, 6180.907286390697, 6198.628082315065, 6211.875762484748, 6232.781852635158, 5622.746976386073, 5644.350899646532, 5648.03983322834, 5664.518515926151, 5668.659880407189, 5650.039493286151, 5679.772809087653, 5738.856528586798, 5760.798372056979, 5785.797497087603, 5683.261176047129, 5737.540996720252, 5740.167675687023, 5747.856303592423, 5771.82684519463, 5566.248556444909, 5664.57515686321, 5743.45437183471, 5794.188813566083, 5799.275090613694, 5604.635698679614, 5644.661320320753, 5668.829935101953, 5673.773049078032, 5716.828495145152, 6068.57519973602, 6133.693315334215, 6152.0, 6165.599236049642, 6211.782587609412, 6554.475641948633, 6583.967080164569, 6633.20401551812, 6645.900311495331, 6648.102506161655, 6639.435647969928, 6668.86662266752, 6670.966645166792, 6684.966575167142, 6690.364415380531, 6170.444659980579, 6174.135621013062, 6176.567640265183, 6180.907286390708, 6184.628922264678, 6764.5603035802515, 6767.593944363354, 6772.085768421299, 6789.456843452512, 6792.694328755218, 6389.712462939179, 6474.1907261592305, 6536.346365363425, 6617.073609694647, 6622.635755033423, 6654.068430419745, 6681.0, 6690.632015239208, 6693.497987650946, 6699.9665001674675, 6536.771213007617, 6539.869202615921, 6560.376764207393, 6636.867262654817, 6649.634270115093, 6562.114114594564, 6585.967070164618, 6615.272320044791, 6627.668616569249, 6677.165354330708, 5474.479924407175, 5486.862828429321, 5487.012337779158, 5488.69812160335, 5489.505944465017, 4692.483826779052, 4693.084848454519, 4697.553732395417, 4703.811847526061, 4717.103750287434, 5723.341815691166, 5787.536997040227, 5796.217510636095, 5800.216970708901, 5801.361850196559, 6688.197416310074, 6693.196816381968, 6703.095082163845, 6703.095082163943, 6725.9663701681175, 5669.177969194444, 5832.0, 5843.853903652358, 5877.9118313225335, 5926.466618004314, 5914.408559144051, 5993.160957465958, 6001.729922153513, 6011.729472173763, 6022.909656355158, 6314.905276420857, 6389.872202555923, 6459.709313080923, 6535.346465353522, 6567.080608714784, 6587.736490540517, 6588.8352791180605, 6606.537542371988, 6606.933930660824, 6609.339066093352, 6390.712417941297, 6449.871002579828, 6459.418652321314, 6464.0, 6492.383223593751, 6091.908621370594, 6543.934560654333, 6544.705488252945, 6649.667516624246, 6656.866862662623, 6676.9666151668935, 6723.630200339028, 6783.796486105425, 6807.89788153188, 6810.557313774589, 6371.585846919936, 6404.391582799627, 6471.741130354922, 6491.578047426902, 6520.347965203442, 6453.451456626051, 6514.446272066927, 6520.18497687789, 6526.086347911391, 6577.6053436793945, 6431.0, 6472.611643301417, 6513.316101809241, 6515.348465153446, 6521.673916304071, 6511.772087976898, 6530.738770449128, 6583.341665833378, 6619.371159739817, 6642.634655093823, 6293.150424692608, 6358.554901156875, 6376.872462550816, 6396.584222025554, 6398.808035758934], "value": 6084.417613582561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.6348175062096, 860.5181098584791, 888.6178943054488, 892.4779004282494, 1205.1142410328412, 32176.0, 43005.0, 43553.78223108888, 43565.78217108914, 43624.56375436245, 44064.55935440645, 44147.558524414744, 44251.557484425146, 44437.55562444375, 44496.0, 7700.499467534606, 7870.645820938072, 7879.763607091796, 7904.05151381835, 7960.880586791174, 7818.413618978571, 7963.243491868263, 7984.6007699615075, 8005.6397462114055, 8012.1186669466315, 8015.158408367125, 8060.959695201545, 8075.555844428554, 8077.474964127342, 8077.838443231132, 7943.245391687809, 7979.601019948979, 7980.162082981262, 7991.041075071, 8003.359731221488, 7877.487963282369, 7924.524528528307, 7954.642041108106, 7956.641951112156, 7958.960205198995, 39985.0, 40094.39858402126, 40272.597274027474, 40279.0, 40321.59678403237, 3567.518385018015, 3605.2068544920076, 3605.4231322988194, 3614.6566076222716, 3625.347437461256, 32324.353512929843, 32361.35277294441, 32451.51322730161, 32487.837560812044, 32556.837215814005, 4760.5715485606115, 4891.192953162724, 4895.192293271606, 4941.530554597308, 4980.078685443168, 193244.0, 193579.0, 197495.0, 197561.0, 199528.0, 49296.507034929906, 49351.753241233564, 49504.75247623739, 49552.752236238586, 49555.50444495581, 52025.7398713004, 52031.0, 52297.0, 52454.0, 52578.73710631422, 14647.853521464862, 14887.553373398816, 15929.0, 16697.83302166987, 17034.0, 13256.204627722367, 13258.602241932758, 13270.402831872396, 13315.866841331657, 13364.39860206293, 15240.542783716506, 15305.234738263041, 15340.463083792014, 15412.075275483507, 15447.5365739028, 5749.3963133871175, 5935.940640593539, 6041.8489537761025, 6045.697715114226, 6106.358832322631, 984.7833476635129, 1018.7911478146962, 1021.5556233038503, 1022.6420752736632, 1024.9590016399409, 22954.770452295597, 23129.190478333516, 23300.184493542984, 23376.298711038697, 23494.88252558726, 1090.5801266512292, 1108.6729414822646, 1123.5168877382803, 1123.6404350607727, 1129.757102223026, 12287.815682764765, 12323.0, 12334.383280835922, 12401.317927514074, 12410.875891240972, 231488.0, 232794.0, 233992.0, 234263.0, 234303.0, 55185.44814551803, 55413.722931385084, 55434.722826386416, 55471.0, 55523.72238138784, 1478.3643033495484, 1503.7067771784616, 1510.3656464285027, 1530.2960638106374, 1534.9309281082378, 22652.433689157904, 22793.88603056974, 22845.428864278525, 22975.425614359774, 23101.19145829888, 38938.0, 38942.61057389503, 39034.80482597569, 39063.0, 39081.41377879391, 193581.0, 194109.0, 194708.0, 195061.0, 195343.0, 35167.64832351746, 36110.27779444449, 36785.632143678224, 36845.63154368422, 37095.0, 47280.76359618318, 47597.0, 48418.0, 48451.75774121107, 48547.0, 35044.29911401809, 35158.29683406369, 35177.29645407027, 35232.29535409329, 35428.114297142776, 34995.47506787349, 35008.47487287642, 35044.47433288554, 35204.647953520136, 35511.289774203855, 37866.0, 37878.0, 37908.241835163695, 38034.429483557215, 38203.617963820005, 34127.0, 34611.82694086614, 34923.65076349204, 34959.0, 35057.82471087628, 24579.0, 24634.864163972627, 25112.0, 25276.46917917566, 25432.364190895376], "value": 17766.740454501003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.784886045582, 559.4098226371182, 565.1268789719883, 566.575068698476, 590.5688847141586, 21215.57568848622, 21777.3466795996, 21823.67264491034, 21851.344459666198, 21876.671849922262, 24275.878620606873, 26280.211593652173, 26288.605670914905, 26380.0, 26424.339391515223, 6520.119783829182, 6646.26891041985, 6651.933480665204, 6664.4668426526005, 6679.265280819106, 5711.9718450678865, 5747.540196784268, 5850.970745146268, 6371.26730426, 6393.4885209183385, 6365.458935990447, 6372.93627063728, 6377.298497165308, 6392.0, 6393.680315984206, 6327.588706734047, 6344.365563443642, 6348.206474190726, 6358.0, 6376.458001069915, 5896.0, 5916.615419997729, 5935.347111817697, 5943.286805583314, 5951.851203719898, 29074.127776166748, 29808.552871706943, 30298.394032119235, 30725.078247652607, 31047.0, 1964.2143142742875, 2007.5483016321357, 2010.788867168941, 2014.0433294185145, 2018.2835093541728, 19114.13986370617, 19703.704444433344, 19787.109580068933, 19791.604167916707, 19874.3043993461, 2196.9231076912392, 2218.389942765736, 2262.2986874069093, 2266.8866556672265, 2270.4664403865077, 131963.0, 137761.0, 137909.0, 138337.0, 138360.30819845837, 14436.123303970417, 14603.342849571794, 14829.18439485817, 14862.331195096247, 15124.168170750494, 23670.64494032591, 23678.4080397988, 23700.88149559241, 23733.288001359986, 23757.287281381585, 10158.746031349276, 10266.589336426608, 10289.382637041801, 10350.0, 10438.217133715001, 9482.288828337765, 9505.524723763923, 9540.0, 9561.952190239004, 9668.129868311886, 7912.744867712674, 9218.400803947721, 9294.163525282756, 9427.15155635996, 9452.52737363129, 2805.2566069991467, 2813.957790633142, 2856.6714827794654, 2860.7425331720247, 2941.6175897133235, 972.2367941166151, 980.0836218136066, 986.0386123529645, 986.8766404199475, 998.3959704378747, 19935.302264420676, 19993.400197994084, 20224.898875505824, 20392.28626998048, 20563.0, 998.9250806189565, 1061.867266591676, 1064.2337516987911, 1065.158524765442, 1080.3841810168285, 10857.294275872044, 11200.887991119984, 11289.49197286124, 11343.092552595772, 11386.202965792316, 510746.0, 520291.0, 521145.0, 527233.0, 527824.0, 115432.42283788696, 117896.41051794686, 118522.0, 122194.38902805607, 122324.38837805754, 1304.7260075384086, 1326.4561529772748, 1326.973460530784, 1329.7207586406962, 1337.0239725000804, 17835.643287134444, 17879.10604469797, 17926.0, 17999.0, 18054.097295135452, 53462.0, 53862.19206711824, 55345.44654553403, 55938.0, 56402.0, 72410.0, 72582.63708681634, 72702.63648681722, 72723.0, 73165.6341718288, 12484.250944943333, 13162.552119266682, 14416.495422660157, 14803.851961480248, 15186.46847360337, 23179.0, 23362.532749344577, 23389.649155262345, 24804.255872323858, 24913.377165571004, 19159.8084019158, 19278.903605481883, 19293.421197364103, 19449.222031118596, 19504.707429388855, 16777.245023973708, 17305.56736081608, 17403.042832644325, 17674.469765907044, 18007.0, 18853.811461885205, 19516.414507564798, 19630.116644751306, 19806.603867922848, 19812.90093549523, 14661.193634350213, 14857.554273371816, 14960.476383326532, 14963.40146394132, 14997.625059373166, 18338.358157464423, 18560.071996400395, 18718.812811871707, 18733.90633046826, 18758.53103672419], "value": 12059.410265357308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.0934188106787, 1430.4421275702477, 1438.661914450104, 1447.225734232186, 1449.9999999999998, 13920.234387108705, 14000.229987350716, 14602.19687917164, 14646.121232726044, 14652.194129322883, 14538.781918271234, 14756.0, 14760.630984225372, 14770.335334909929, 14784.926075369634, 2700.054980756734, 2728.5088684036864, 2730.57676060211, 2735.1657744387953, 2735.384538478846, 2619.358257226982, 2626.93432664183, 2664.6136310235006, 2680.32991752062, 2680.437108207279, 2614.6078088286718, 2641.630171775953, 2684.7852171826303, 2723.8774255158564, 2729.877155527996, 2645.31221882311, 2648.6821581410354, 2652.456246469469, 2660.7472290132405, 2661.42779302449, 2565.9230223093336, 2580.135654555726, 2585.650937123483, 2588.741125887415, 2588.8835002424935, 13691.589252322447, 13927.651808704763, 13930.721385572231, 13939.442422303096, 13951.302434878215, 7671.079470463525, 7879.290863822283, 7922.920770792276, 7926.167752385974, 7926.8810967835525, 4988.575971042465, 5086.618503612207, 5130.846074617767, 5207.375114986188, 5209.765560549784, 1810.2939853457162, 1811.1345314326265, 1811.9219064656509, 1843.75109360236, 1857.8606604504716, 22861.31416057521, 23054.193103241305, 23058.847057647217, 23082.192123275774, 23130.537389252288, 6346.524010699216, 6416.839579010562, 6488.610683359014, 6490.8052758417325, 6714.899276510856, 16034.75947860783, 16045.759313610306, 16216.0, 16608.169591520375, 16654.250558724885, 7527.0, 7776.65005074773, 7786.221377862282, 7805.765827025199, 7826.921730782733, 7163.820904477429, 7214.531055481482, 7262.6731797068205, 7295.416366690652, 7329.19378868324, 4965.255211718271, 5150.124478838607, 5177.611679124081, 5181.549166233461, 5182.714950677673, 1506.7212565675386, 1527.1447989125902, 1527.3585094260438, 1539.1842323568526, 1547.4506550174751, 907.981840363189, 937.929655275857, 940.7318914109583, 941.5715849288557, 949.6818565780403, 7593.0, 7628.69485220596, 7632.961835190788, 7658.0, 7712.460127791001, 706.6537396675592, 719.6977269546699, 725.5392825555705, 725.9528130671489, 735.4594373135741, 4572.513932971731, 4639.9536004640195, 5205.895882082337, 5330.866728331823, 5394.78420863161, 19241.51896202578, 20141.697874531892, 20148.697769533468, 20481.692774608393, 20501.077451514717, 18738.437846864617, 19573.412797616093, 19590.608187836162, 19701.84711055201, 19834.60330793405, 11072.058874995715, 11146.386948717736, 11170.27393219438, 11211.439428028565, 11219.831702524469, 7639.350655194148, 8041.798955025937, 8615.439996400213, 8741.169588889044, 8776.517291549026, 16475.58811029734, 16901.577460563094, 17003.7449438261, 17006.914965425094, 17669.204885779913, 16920.74618880693, 17440.47678569645, 17643.558911026812, 17844.464666060037, 17954.281828726704, 13195.076344655781, 13243.933780331423, 13486.12340197884, 13489.595312140651, 13494.595162145151, 13388.464461421823, 13508.932455337661, 13590.796138058135, 13600.523981660594, 13608.0, 10848.728781780519, 10857.185711071543, 10905.563777448813, 10928.344299342065, 11076.944615277194, 10293.073623373932, 10702.946485267525, 10763.300385474919, 10773.569057237935, 10936.671899843017, 9434.622615095319, 9497.525123743924, 9504.857427138737, 9585.712428627152, 9603.951980240334, 6945.826354340979, 6965.407940324926, 7015.543989640657, 7079.610621415665, 7218.855622887408, 7307.159676637042, 7328.157261914735, 7385.8153546161775, 7411.370033547209, 7523.0], "value": 6440.493551068599, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.3959248901317, 505.9190529515277, 531.1475082492599, 538.5906710899715, 541.610040770645, 6264.154339164212, 6353.205849268841, 6370.17187765591, 6442.742290308393, 6445.291017988017, 6071.939280607193, 6146.784862529812, 6194.59735117217, 6239.0, 6264.749410023605, 4923.261510773395, 5033.546980771748, 5049.712323357548, 5063.316452278932, 5075.467075957026, 4956.479569645189, 5071.315372424712, 5073.137566613685, 5074.391073071218, 5114.2072978688175, 4808.158572249859, 4915.434725006634, 4954.810845397097, 4982.5764809991015, 5030.195168772997, 4864.8540543783565, 4924.285978533128, 4932.482089380599, 5005.2492126181, 5007.674501157413, 4465.307877278994, 4473.865784026484, 4496.505384407713, 4498.955010449887, 4509.977450112761, 6127.4791642710425, 6151.200343955302, 6153.692315384257, 6177.042558403455, 6191.535634827406, 5709.288088158133, 5741.081426971707, 5770.855728606818, 5771.884562308773, 5784.3926387729525, 6526.771562995273, 6528.51036172289, 6617.172853393326, 6620.503462240351, 6635.568688035262, 4858.271259311132, 4875.488073752276, 4887.315775791392, 4916.680415772999, 4927.211646136637, 6799.218089919673, 6872.244053154149, 6894.724211031553, 6935.653217339112, 7013.82465438363, 4980.601551875841, 4990.902001559651, 5041.470645582234, 5057.848264552069, 5060.84817455477, 5073.137566613685, 5133.435322114565, 5133.486651334912, 5134.71632091977, 5158.039944821019, 5610.887782244332, 5633.155026745939, 5727.224560386294, 5778.27771528559, 5815.941840581625, 6500.967495162494, 6567.802965911031, 6570.8028759137305, 6602.2407423146, 6621.9006714899315, 1674.8325167483397, 1696.787901512311, 1732.9306827727003, 1747.5106970048153, 1778.1287169287216, 1193.5345215366015, 1227.2636418149038, 1228.177121328712, 1230.5569994801865, 1249.8875101240933, 5768.942310576925, 5781.508571771363, 5831.591788574759, 5832.533397328203, 5839.970800146057, 6575.914974029327, 6649.434798042221, 6716.697748601325, 6770.932290677129, 6785.423239024738, 5847.239858818411, 5870.148828419855, 5890.293164820249, 5909.0, 5911.822645320647, 3514.9824250878582, 3587.497750314958, 3591.8204089795404, 3603.8647825934745, 3626.1841085755495, 6609.537332386687, 6624.735010599618, 6634.0, 6687.531872768859, 6693.330666933268, 6869.793906182823, 6919.37725604698, 6991.475639327071, 6992.475564332695, 6996.6851491683, 6549.345065493412, 6560.868782624225, 6586.967065164739, 6612.107365505595, 6626.370494802986, 6853.520253582401, 6854.760083397057, 6865.347791959756, 6874.450043996369, 6904.896426553706, 6770.966145169243, 6782.186137663314, 6807.413182990432, 6814.693338799667, 6817.454603631797, 6644.833879152867, 6665.733370665119, 6666.83332916681, 6669.933300666931, 6706.429953454011, 4991.401031876198, 5043.142665746906, 5043.470435604208, 5073.695578265316, 5074.4120498546745, 6807.0, 6842.726290948306, 6860.965695171492, 6904.447644188554, 6955.513114081966, 6606.933930660632, 6611.140551728245, 6620.8344791380605, 6646.136002319668, 6707.295733947865, 6328.557001009885, 6500.739970401131, 6589.242237142598, 6720.8319792005595, 6757.222919364336, 6376.171097757262, 6497.902531462127, 6507.479401647952, 6534.281229064704, 6570.5729127606555, 6661.4004739573675, 6661.966690166518, 6662.766803161866, 6664.866702665822, 6674.566153200027, 6328.841993775059, 6361.936380636134, 6406.87186256263, 6437.549371543947, 6453.677316134081], "value": 5103.874351976207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.9269658427326, 915.3272344826555, 938.1744065222603, 940.8071345374199, 943.2312665177877, 19134.904325478372, 19757.110930008148, 19950.90024549877, 19983.800161998377, 22777.886110569467, 19302.90348548255, 19316.71024934627, 19732.408027759153, 19839.305624303153, 20019.799802001977, 794.3764145146062, 800.6237068577789, 1046.4819914142472, 1051.1223128687516, 1055.4036969112465, 1070.70555597211, 1075.295681328731, 1075.779465209634, 1075.8386242063675, 1076.2358725305044, 1117.5250518529633, 1118.9720256993598, 1119.0096764363516, 1121.9831702524468, 1122.84841546391, 1117.3631030312683, 1119.160629527854, 1122.5790328626765, 1125.656674714212, 1127.222216670503, 813.4915677701437, 817.4441379861692, 818.7216346442239, 819.2544784246367, 823.7611092783086, 19252.32616858417, 19859.30492432758, 19911.90044049785, 19989.200431982703, 20109.09509072095, 21306.041228144615, 21614.783852161436, 21736.891315543322, 22233.44416389587, 22264.666030009565, 15109.773353399707, 15136.54590362291, 15182.772258416133, 15240.0, 15271.618209544738, 3529.75291729579, 3553.271579326258, 3557.7331700122336, 3558.4128618777872, 3558.5907620623702, 122144.0, 126032.36983815113, 128549.35725321407, 128737.35631321877, 129317.0, 17724.91137544304, 18107.637847243244, 18194.90902545479, 18341.0, 18546.0, 32299.0, 32545.34909301801, 32623.836880815918, 32655.346893062007, 32833.671663283065, 7545.660445279866, 9052.411593246417, 9126.58930348136, 9141.085891410805, 9155.725328240163, 4021.4168945503325, 4161.812718427678, 4168.124693814333, 4173.791310434466, 4202.873913782591, 5038.143515602356, 5137.0, 5151.25306830515, 5154.8969020620125, 5165.509276618715, 987.9357841740264, 988.9752756181009, 1001.8797744270735, 1002.9097381235724, 1006.9647562335283, 685.7908337956871, 707.7664370757637, 715.1382583986388, 723.5586292361655, 737.9631018449056, 12051.0, 12212.206206596542, 12591.748165036648, 13090.803637945439, 13524.0, 695.6799872058909, 699.6152116335995, 700.1493185779302, 711.0791524975169, 717.2683862460261, 5607.383187849333, 6040.335563088057, 6295.338989406138, 6554.279029306773, 6715.630640314829, 108587.0, 108889.0, 111423.44288278506, 112104.4394778021, 118094.0, 95760.52119739496, 101572.49213753884, 103541.48229258956, 104696.0, 109061.45469272602, 86790.0, 87084.0, 88312.55843720741, 90267.54866225627, 90298.09701903028, 12005.279683219034, 12158.270503769449, 12198.939005304917, 12387.876121238673, 12547.306113674536, 37821.243575128894, 38363.0, 38563.421548677354, 39232.80383598064, 40389.0, 49333.753331233114, 50386.49613503965, 50730.2390464136, 51514.74242628763, 52290.0, 18684.626307473503, 19209.711854322475, 19225.807741922403, 19797.802021979594, 19818.0, 21922.561548769256, 22225.555488890455, 22332.21837235689, 22764.0, 22976.0, 19666.311679091163, 19734.901325493855, 19963.301284455556, 20253.18987240494, 20392.694109588665, 17444.91277543604, 18126.18432170582, 18157.909210453865, 18229.726554101966, 18241.270349185885, 17599.472015839547, 18025.549361266072, 18548.814511854707, 19154.425367239004, 19438.222471101, 13420.865791342352, 13438.798418023542, 13545.796813047615, 13780.586582402544, 13802.447902084206, 15098.849011509745, 15223.865730364882, 15326.770098448309, 15368.462103826312, 15392.230388480755], "value": 9311.60761790778, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 103.0, 113.0, 119.0, 114.0, 108.0, 103.0, 108.0, 109.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 162.0, 180.0, 115.0, 140.0, 146.0, 120.0, 171.0, 119.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 161.0, 162.0, 165.0, 168.0, 167.0, 163.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 172.0, 82.0, 76.0, 74.0, 82.0, 162.0, 80.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 136.0, 78.0, 79.0, 78.0, 137.0, 79.0, 79.0, 130.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 117.0, 114.0, 114.0, 114.0, 120.0, 115.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 156.0, 151.0, 152.0, 150.0, 153.0, 151.0, 152.0, 153.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 55.0, 53.0, 55.0, 54.0, 54.0, 57.0, 58.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 55.0, 57.0, 63.0, 55.0, 55.0, 54.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 75.0, 76.0, 75.0, 75.0, 75.0, 86.0, 79.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 132.0, 121.0, 117.0, 126.0, 120.0, 123.0, 120.0, 192.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 178.0, 172.0, 172.0, 169.0, 171.0, 170.0, 167.0, 174.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 74.0, 72.0, 70.0, 69.0, 67.0, 69.0, 66.0, 67.0], "value": 69.2, "unit": "score"}]}]} 17:07:25 INFO - Return code: 0 17:07:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:07:25 INFO - # TBPL SUCCESS # 17:07:25 INFO - Running post-action listener: _package_coverage_data 17:07:25 INFO - Running post-action listener: _resource_record_post_action 17:07:25 INFO - [mozharness: 2017-08-19 00:07:25.654708Z] Finished run-tests step (success) 17:07:25 INFO - Running post-run listener: _resource_record_post_run 17:07:25 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 24576; Write bytes: 445616128; Read time: 304; Write time: 523632 17:07:25 INFO - TinderboxPrint: CPU usage
13.2% 17:07:25 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 304 17:07:25 INFO - TinderboxPrint: I/O write bytes / time
445,616,128 / 523,632 17:07:25 INFO - TinderboxPrint: CPU idle
8,263.7 (86.8%) 17:07:25 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 17:07:25 INFO - TinderboxPrint: Swap in / out
0 / 0 17:07:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121524224; Read time: 32; Write time: 140212 17:07:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:07:25 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 16384; Write bytes: 324091904; Read time: 256; Write time: 383420 17:07:26 INFO - Running post-run listener: _upload_blobber_files 17:07:26 INFO - Blob upload gear active. 17:07:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:07:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:07:26 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:07:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:27 INFO - (blobuploader) - INFO - Done attempting. 17:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:28 INFO - (blobuploader) - INFO - Done attempting. 17:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:29 INFO - (blobuploader) - INFO - Done attempting. 17:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:36 INFO - (blobuploader) - INFO - Done attempting. 17:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:36 INFO - Return code: 0 17:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e33894be77c546e3e3d896aad5b2be2791e4718bbb80cf4fd8213f7b6641a84829b8ceb02d89a9eea3402e25d4ef46e389e33dbb8ff561bc6dec8d609114c98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87a33c5b0bb513a2d050637208ccdb0a9b1b25dc7f61b54067ccc26554715ff3ae9db330d5272bd19ba4be605b3f31d61e8abfa5605bf646ca4dec63e68314f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/753dc6759f98ef767b57d3bb92fe186bb6a2df1a3476f7bf797ee340e6b8c5373939ed31fdc352f2a3827be78c8cb97f29fce0df12763b75cb0eb75bcf1c9818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d7362aef72cce463446fcf02d8c442fe518d8b79152d847f5f64661ee454e6817a094443750188510d1d732f843056d56b7329146de57c7880ed2d2bf93466"} 17:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:07:36 INFO - Contents: 17:07:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e33894be77c546e3e3d896aad5b2be2791e4718bbb80cf4fd8213f7b6641a84829b8ceb02d89a9eea3402e25d4ef46e389e33dbb8ff561bc6dec8d609114c98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87a33c5b0bb513a2d050637208ccdb0a9b1b25dc7f61b54067ccc26554715ff3ae9db330d5272bd19ba4be605b3f31d61e8abfa5605bf646ca4dec63e68314f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/753dc6759f98ef767b57d3bb92fe186bb6a2df1a3476f7bf797ee340e6b8c5373939ed31fdc352f2a3827be78c8cb97f29fce0df12763b75cb0eb75bcf1c9818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d7362aef72cce463446fcf02d8c442fe518d8b79152d847f5f64661ee454e6817a094443750188510d1d732f843056d56b7329146de57c7880ed2d2bf93466"} 17:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:36 INFO - Copying logs to upload dir... 17:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 17:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.964167 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-18 17:07:36.647818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:07:36.652153) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e33894be77c546e3e3d896aad5b2be2791e4718bbb80cf4fd8213f7b6641a84829b8ceb02d89a9eea3402e25d4ef46e389e33dbb8ff561bc6dec8d609114c98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87a33c5b0bb513a2d050637208ccdb0a9b1b25dc7f61b54067ccc26554715ff3ae9db330d5272bd19ba4be605b3f31d61e8abfa5605bf646ca4dec63e68314f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/753dc6759f98ef767b57d3bb92fe186bb6a2df1a3476f7bf797ee340e6b8c5373939ed31fdc352f2a3827be78c8cb97f29fce0df12763b75cb0eb75bcf1c9818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d7362aef72cce463446fcf02d8c442fe518d8b79152d847f5f64661ee454e6817a094443750188510d1d732f843056d56b7329146de57c7880ed2d2bf93466"} build_url:https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/MG9qgLVdSh6Lrf5lTYxwFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e33894be77c546e3e3d896aad5b2be2791e4718bbb80cf4fd8213f7b6641a84829b8ceb02d89a9eea3402e25d4ef46e389e33dbb8ff561bc6dec8d609114c98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87a33c5b0bb513a2d050637208ccdb0a9b1b25dc7f61b54067ccc26554715ff3ae9db330d5272bd19ba4be605b3f31d61e8abfa5605bf646ca4dec63e68314f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/753dc6759f98ef767b57d3bb92fe186bb6a2df1a3476f7bf797ee340e6b8c5373939ed31fdc352f2a3827be78c8cb97f29fce0df12763b75cb0eb75bcf1c9818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d7362aef72cce463446fcf02d8c442fe518d8b79152d847f5f64661ee454e6817a094443750188510d1d732f843056d56b7329146de57c7880ed2d2bf93466"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 17:07:36.681119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:07:36.681415) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503099998.394713-462384848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 17:07:36.763686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:07:36.764057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 17:07:36.764345) ========= ========= Total master_lag: 0.19 =========