builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1503662185.49 results: success (0) revision: b6b8e616de32af50c9a174006b3a7ed914130aa5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.486591) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.487014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.487534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.536419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.536746) ========= 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=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 04:56:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.4K=0.2s 2017-08-25 04:56:25 (58.4 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.318380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.876613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.876923) ========= 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=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018119 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.942653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 04:56:25.942952) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b6b8e616de32af50c9a174006b3a7ed914130aa5 --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 b6b8e616de32af50c9a174006b3a7ed914130aa5 --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=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 04:56:26,072 truncating revision to first 12 chars 2017-08-25 04:56:26,072 Setting DEBUG logging. 2017-08-25 04:56:26,072 attempt 1/10 2017-08-25 04:56:26,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b6b8e616de32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 04:56:27,230 unpacking tar archive at: mozilla-central-b6b8e616de32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.536081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 04:56:27.498990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:27.499321) ========= script_repo_revision: b6b8e616de32af50c9a174006b3a7ed914130aa5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:27.499691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:27.499961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:27.515985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-25 04:56:27.516361) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:27 INFO - MultiFileLogger online at 20170825 04:56:27 in /builds/slave/test 04:56:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:56:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:27 INFO - {'append_to_log': False, 04:56:27 INFO - 'base_work_dir': '/builds/slave/test', 04:56:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:27 INFO - 'branch': 'Firefox-Non-PGO', 04:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:27 INFO - 'code_coverage': False, 04:56:27 INFO - 'config_files': ('talos/linux_config.py',), 04:56:27 INFO - 'default_actions': ('clobber', 04:56:27 INFO - 'read-buildbot-config', 04:56:27 INFO - 'download-and-extract', 04:56:27 INFO - 'populate-webroot', 04:56:27 INFO - 'create-virtualenv', 04:56:27 INFO - 'install', 04:56:27 INFO - 'setup-mitmproxy', 04:56:27 INFO - 'run-tests'), 04:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:27 INFO - 'disable_ccov_upload': False, 04:56:27 INFO - 'download_minidump_stackwalk': True, 04:56:27 INFO - 'download_symbols': 'ondemand', 04:56:27 INFO - 'enable_stylo': False, 04:56:27 INFO - 'enable_webrender': False, 04:56:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:27 INFO - 'gecko_profile': False, 04:56:27 INFO - 'gecko_profile_interval': 0, 04:56:27 INFO - 'installer_path': 'installer.exe', 04:56:27 INFO - 'log_level': 'info', 04:56:27 INFO - 'log_name': 'talos', 04:56:27 INFO - 'log_to_console': True, 04:56:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:27 INFO - 'opt_config_files': (), 04:56:27 INFO - 'pip_index': False, 04:56:27 INFO - 'suite': 'dromaeojs-e10s', 04:56:27 INFO - 'system_bits': '32', 04:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:27 INFO - 'title': 'talos-linux64-ix-020', 04:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:27 INFO - 'use_talos_json': True, 04:56:27 INFO - 'verify': 'False', 04:56:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:27 INFO - 'work_dir': 'build'} 04:56:27 INFO - [mozharness: 2017-08-25 11:56:27.779931Z] Running clobber step. 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: clobber 04:56:27 INFO - rmtree: /builds/slave/test/build 04:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:28 INFO - Running post-action listener: _resource_record_post_action 04:56:28 INFO - [mozharness: 2017-08-25 11:56:28.811216Z] Finished clobber step (success) 04:56:28 INFO - [mozharness: 2017-08-25 11:56:28.811313Z] Running read-buildbot-config step. 04:56:28 INFO - Running pre-action listener: _resource_record_pre_action 04:56:28 INFO - Running main action method: read_buildbot_config 04:56:28 INFO - Using buildbot properties: 04:56:28 INFO - { 04:56:28 INFO - "project": "", 04:56:28 INFO - "product": "firefox", 04:56:28 INFO - "who": "archaeopteryx@coole-files.de", 04:56:28 INFO - "installer_path": "public/build/target.tar.bz2", 04:56:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:56:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:56:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:56:28 INFO - "stage_platform": "linux64", 04:56:28 INFO - "basedir": "/builds/slave/test", 04:56:28 INFO - "buildnumber": 789, 04:56:28 INFO - "platform": "ubuntu64_hw", 04:56:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:56:28 INFO - "slavebuilddir": "test", 04:56:28 INFO - "taskId": "QDfh6M-8TNqd2NPnxUn2BQ", 04:56:28 INFO - "branch": "mozilla-central", 04:56:28 INFO - "script_repo_revision": "production", 04:56:28 INFO - "revision": "b6b8e616de32af50c9a174006b3a7ed914130aa5", 04:56:28 INFO - "slavename": "talos-linux64-ix-020", 04:56:28 INFO - "repo_path": "mozilla-central" 04:56:28 INFO - } 04:56:28 INFO - Finding installer, test and symbols from parent task. 04:56:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDfh6M-8TNqd2NPnxUn2BQ'}, attempt #1 04:56:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDfh6M-8TNqd2NPnxUn2BQ'}, attempt #1 04:56:29 INFO - Task dependencies: aS8yyg60SCGqrPCGhs8emA 04:56:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA'}, attempt #1 04:56:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json 04:56:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip 04:56:30 INFO - Running post-action listener: _resource_record_post_action 04:56:30 INFO - [mozharness: 2017-08-25 11:56:30.141010Z] Finished read-buildbot-config step (success) 04:56:30 INFO - [mozharness: 2017-08-25 11:56:30.141227Z] Running download-and-extract step. 04:56:30 INFO - Running pre-action listener: _resource_record_pre_action 04:56:30 INFO - Running main action method: download_and_extract 04:56:30 INFO - mkdir: /builds/slave/test/build/tests 04:56: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')]} 04:56:30 INFO - trying https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json 04:56:30 INFO - Downloading https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:56:30 INFO - Downloaded 989 bytes. 04:56:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:56:30 INFO - Using the following test package requirements: 04:56:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:56:30 INFO - u'common': [u'target.common.tests.zip'], 04:56:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:56:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:56:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:56:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:56:30 INFO - u'mozbase': [u'target.common.tests.zip'], 04:56:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:56:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:56:30 INFO - u'web-platform': [u'target.common.tests.zip', 04:56:30 INFO - u'target.web-platform.tests.tar.gz'], 04:56:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:56:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:56:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip 04:56:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:56:30 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip into memory 04:56:31 INFO - Content-Length response header: 54980292 04:56:31 INFO - Bytes received: 54980292 04:56:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:56:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip 04:56:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:56:42 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip into memory 04:56:43 INFO - Content-Length response header: 54980292 04:56:43 INFO - Bytes received: 54980292 04:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip 04:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip into memory 04:56:56 INFO - Content-Length response header: 14496611 04:56:56 INFO - Bytes received: 14496611 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:56 INFO - trying https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:56 INFO - Downloading https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:56:57 INFO - Downloaded 61120310 bytes. 04:56:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:57 INFO - mkdir: /builds/slave/test/properties 04:56:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:57 INFO - Contents: 04:56:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:57 INFO - Running post-action listener: _resource_record_post_action 04:56:57 INFO - Running post-action listener: find_tests_for_verification 04:56:57 INFO - Running post-action listener: set_extra_try_arguments 04:56:57 INFO - [mozharness: 2017-08-25 11:56:57.817561Z] Finished download-and-extract step (success) 04:56:57 INFO - [mozharness: 2017-08-25 11:56:57.817658Z] Running populate-webroot step. 04:56:57 INFO - Running pre-action listener: _resource_record_pre_action 04:56:57 INFO - Running main action method: populate_webroot 04:56:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:57 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:57 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:57 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'tests': ['damp', 'tps']}, 04:56:57 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['damp', 'tps']}, 04:56:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:56:57 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:56:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:56:57 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:56:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:57 INFO - 'ts_paint', 04:56:57 INFO - 'tpaint', 04:56:57 INFO - 'sessionrestore', 04:56:57 INFO - 'sessionrestore_many_windows', 04:56:57 INFO - 'sessionrestore_no_auto_restore', 04:56:57 INFO - 'tabpaint']}, 04:56:57 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['a11yr', 04:56:57 INFO - 'ts_paint', 04:56:57 INFO - 'tpaint', 04:56:57 INFO - 'sessionrestore', 04:56:57 INFO - 'sessionrestore_many_windows', 04:56:57 INFO - 'sessionrestore_no_auto_restore', 04:56:57 INFO - 'tabpaint']}, 04:56:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:56:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:56:57 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['bloom_basic_singleton']}, 04:56:57 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['bloom_basic']}, 04:56:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:57 INFO - 'tsvgr_opacity', 04:56:57 INFO - 'tart', 04:56:57 INFO - 'tscrollx', 04:56:57 INFO - 'tsvg_static']}, 04:56:57 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['tsvgx', 04:56:57 INFO - 'tsvgr_opacity', 04:56:57 INFO - 'tart', 04:56:57 INFO - 'tscrollx', 04:56:57 INFO - 'tsvg_static']}, 04:56:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:56:57 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--stylo'], 04:56:57 INFO - 'tests': ['tp5o']}, 04:56:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:57 INFO - 'talos_options': ['--mitmproxy', 04:56:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:57 INFO - '--firstNonBlankPaint'], 04:56:57 INFO - 'tests': ['tp6_google', 04:56:57 INFO - 'tp6_youtube', 04:56:57 INFO - 'tp6_amazon', 04:56:57 INFO - 'tp6_facebook']}, 04:56:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:57 INFO - 'talos_options': ['--stylo', 04:56:57 INFO - '--mitmproxy', 04:56:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:57 INFO - '--firstNonBlankPaint'], 04:56:57 INFO - 'tests': ['tp6_google', 04:56:57 INFO - 'tp6_youtube', 04:56:57 INFO - 'tp6_amazon', 04:56:57 INFO - 'tp6_facebook']}, 04:56:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:57 INFO - 'talos_options': ['--stylo', 04:56:57 INFO - '--stylo-threads=1', 04:56:57 INFO - '--mitmproxy', 04:56:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:57 INFO - '--firstNonBlankPaint'], 04:56:57 INFO - 'tests': ['tp6_google', 04:56:57 INFO - 'tp6_youtube', 04:56:57 INFO - 'tp6_amazon', 04:56:57 INFO - 'tp6_facebook']}, 04:56:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--xperf_path', 04:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:57 INFO - 'tests': ['tp5n']}, 04:56:57 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:57 INFO - 'talos_options': ['--stylo', 04:56:57 INFO - '--xperf_path', 04:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:57 INFO - 'tests': ['tp5n']}}} 04:56:57 INFO - Running post-action listener: _resource_record_post_action 04:56:57 INFO - [mozharness: 2017-08-25 11:56:57.831770Z] Finished populate-webroot step (success) 04:56:57 INFO - [mozharness: 2017-08-25 11:56:57.831859Z] Running create-virtualenv step. 04:56:57 INFO - Running pre-action listener: _resource_record_pre_action 04:56:57 INFO - Running main action method: create_virtualenv 04:56:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:56:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:56:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:56:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:58 INFO - Installing pip...............done. 04:56:58 INFO - Return code: 0 04:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:58 INFO - Reading from file tmpfile_stdout 04:56:58 INFO - Output received: 04:56:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:56:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:56:58 INFO - Using env: {'DISPLAY': ':0', 04:56:58 INFO - 'HOME': '/home/cltbld', 04:56:58 INFO - 'LANG': 'en_US.UTF-8', 04:56:58 INFO - 'LANGUAGE': 'en_US:en', 04:56:58 INFO - 'LOGNAME': 'cltbld', 04:56:58 INFO - 'MAIL': '/var/mail/cltbld', 04:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:58 INFO - 'MOZ_NO_REMOTE': '1', 04:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:58 INFO - 'NO_EM_RESTART': '1', 04:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:58 INFO - 'PWD': '/builds/slave/test', 04:56:58 INFO - 'SHELL': '/bin/bash', 04:56:58 INFO - 'SHLVL': '1', 04:56:58 INFO - 'TERM': 'linux', 04:56:58 INFO - 'TMOUT': '86400', 04:56:58 INFO - 'USER': 'cltbld', 04:56:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:58 INFO - '_': '/tools/buildbot/bin/python'} 04:57:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:57:00 INFO - Downloading/unpacking pip>=1.5 04:57:00 INFO - Running setup.py egg_info for package pip 04:57:00 INFO - warning: no files found matching 'pip/cacert.pem' 04:57:00 INFO - warning: no files found matching '*.html' under directory 'docs' 04:57:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:57:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:57:00 INFO - Installing collected packages: pip 04:57:00 INFO - Found existing installation: pip 1.1 04:57:00 INFO - Uninstalling pip: 04:57:00 INFO - Successfully uninstalled pip 04:57:00 INFO - Running setup.py install for pip 04:57:00 INFO - warning: no files found matching 'pip/cacert.pem' 04:57:00 INFO - warning: no files found matching '*.html' under directory 'docs' 04:57:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:57:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:57:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:57:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:57:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:57:00 INFO - Successfully installed pip 04:57:00 INFO - Cleaning up... 04:57:00 INFO - Return code: 0 04:57:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:00 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:00 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 04:57:00 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 04:57:00 INFO - Using env: {'DISPLAY': ':0', 04:57:00 INFO - 'HOME': '/home/cltbld', 04:57:00 INFO - 'LANG': 'en_US.UTF-8', 04:57:00 INFO - 'LANGUAGE': 'en_US:en', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MAIL': '/var/mail/cltbld', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SHLVL': '1', 04:57:00 INFO - 'TERM': 'linux', 04:57:00 INFO - 'TMOUT': '86400', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - '_': '/tools/buildbot/bin/python'} 04:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:00 INFO - Downloading/unpacking psutil>=3.1.1 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:01 INFO - Installing collected packages: psutil 04:57:01 INFO - Running setup.py install for psutil 04:57:01 INFO - building 'psutil._psutil_linux' extension 04:57:01 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 04:57:01 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 04:57:01 INFO - building 'psutil._psutil_posix' extension 04:57:01 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 04:57:01 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 04:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:01 INFO - Successfully installed psutil 04:57:01 INFO - Cleaning up... 04:57:02 INFO - Return code: 0 04:57:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:57:02 INFO - Using env: {'DISPLAY': ':0', 04:57:02 INFO - 'HOME': '/home/cltbld', 04:57:02 INFO - 'LANG': 'en_US.UTF-8', 04:57:02 INFO - 'LANGUAGE': 'en_US:en', 04:57:02 INFO - 'LOGNAME': 'cltbld', 04:57:02 INFO - 'MAIL': '/var/mail/cltbld', 04:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:02 INFO - 'MOZ_NO_REMOTE': '1', 04:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:02 INFO - 'NO_EM_RESTART': '1', 04:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:02 INFO - 'PWD': '/builds/slave/test', 04:57:02 INFO - 'SHELL': '/bin/bash', 04:57:02 INFO - 'SHLVL': '1', 04:57:02 INFO - 'TERM': 'linux', 04:57:02 INFO - 'TMOUT': '86400', 04:57:02 INFO - 'USER': 'cltbld', 04:57:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:02 INFO - '_': '/tools/buildbot/bin/python'} 04:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:02 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 04:57:02 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 04:57:02 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 04:57:02 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 04:57:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:03 INFO - Installing collected packages: mozsystemmonitor 04:57:03 INFO - Running setup.py install for mozsystemmonitor 04:57:03 INFO - Successfully installed mozsystemmonitor 04:57:03 INFO - Cleaning up... 04:57:03 INFO - Return code: 0 04:57:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:03 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')]} 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:03 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')]} 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:03 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:03 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 04:57:03 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 04:57:03 INFO - Using env: {'DISPLAY': ':0', 04:57:03 INFO - 'HOME': '/home/cltbld', 04:57:03 INFO - 'LANG': 'en_US.UTF-8', 04:57:03 INFO - 'LANGUAGE': 'en_US:en', 04:57:03 INFO - 'LOGNAME': 'cltbld', 04:57:03 INFO - 'MAIL': '/var/mail/cltbld', 04:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:03 INFO - 'MOZ_NO_REMOTE': '1', 04:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:03 INFO - 'NO_EM_RESTART': '1', 04:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:03 INFO - 'PWD': '/builds/slave/test', 04:57:03 INFO - 'SHELL': '/bin/bash', 04:57:03 INFO - 'SHLVL': '1', 04:57:03 INFO - 'TERM': 'linux', 04:57:03 INFO - 'TMOUT': '86400', 04:57:03 INFO - 'USER': 'cltbld', 04:57:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:03 INFO - '_': '/tools/buildbot/bin/python'} 04:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:03 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 04:57:03 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 04:57:03 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 04:57:03 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 04:57:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:06 INFO - warning: no files found matching '*.txt' 04:57:06 INFO - no previously-included directories found matching 'build' 04:57:06 INFO - no previously-included directories found matching 'dist' 04:57:06 INFO - no previously-included directories found matching '.git*' 04:57:06 INFO - Installing collected packages: jsonschema, functools32 04:57:06 INFO - Running setup.py install for functools32 04:57:06 INFO - warning: no files found matching '*.txt' 04:57:06 INFO - no previously-included directories found matching 'build' 04:57:06 INFO - no previously-included directories found matching 'dist' 04:57:06 INFO - no previously-included directories found matching '.git*' 04:57:06 INFO - Successfully installed jsonschema functools32 04:57:06 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:57:06 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')]} 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:06 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')]} 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:06 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:06 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 04:57:06 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 04:57:06 INFO - Using env: {'DISPLAY': ':0', 04:57:06 INFO - 'HOME': '/home/cltbld', 04:57:06 INFO - 'LANG': 'en_US.UTF-8', 04:57:06 INFO - 'LANGUAGE': 'en_US:en', 04:57:06 INFO - 'LOGNAME': 'cltbld', 04:57:06 INFO - 'MAIL': '/var/mail/cltbld', 04:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:06 INFO - 'MOZ_NO_REMOTE': '1', 04:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:06 INFO - 'NO_EM_RESTART': '1', 04:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:06 INFO - 'PWD': '/builds/slave/test', 04:57:06 INFO - 'SHELL': '/bin/bash', 04:57:06 INFO - 'SHLVL': '1', 04:57:06 INFO - 'TERM': 'linux', 04:57:06 INFO - 'TMOUT': '86400', 04:57:06 INFO - 'USER': 'cltbld', 04:57:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:06 INFO - '_': '/tools/buildbot/bin/python'} 04:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:57:06 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:06 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')]} 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:06 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')]} 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:06 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:06 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 04:57:06 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 04:57:06 INFO - Using env: {'DISPLAY': ':0', 04:57:06 INFO - 'HOME': '/home/cltbld', 04:57:06 INFO - 'LANG': 'en_US.UTF-8', 04:57:06 INFO - 'LANGUAGE': 'en_US:en', 04:57:06 INFO - 'LOGNAME': 'cltbld', 04:57:06 INFO - 'MAIL': '/var/mail/cltbld', 04:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:06 INFO - 'MOZ_NO_REMOTE': '1', 04:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:06 INFO - 'NO_EM_RESTART': '1', 04:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:06 INFO - 'PWD': '/builds/slave/test', 04:57:06 INFO - 'SHELL': '/bin/bash', 04:57:06 INFO - 'SHLVL': '1', 04:57:06 INFO - 'TERM': 'linux', 04:57:06 INFO - 'TMOUT': '86400', 04:57:06 INFO - 'USER': 'cltbld', 04:57:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:06 INFO - '_': '/tools/buildbot/bin/python'} 04:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - Downloading docopt-0.6.1.tar.gz 04:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:08 INFO - Running setup.py install for blobuploader 04:57:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:08 INFO - Running setup.py install for requests 04:57:08 INFO - Running setup.py install for docopt 04:57:09 INFO - Successfully installed blobuploader requests docopt 04:57:09 INFO - Cleaning up... 04:57:09 INFO - Return code: 0 04:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57: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')]} 04:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:09 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:09 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 04:57:09 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 04:57:09 INFO - Using env: {'DISPLAY': ':0', 04:57:09 INFO - 'HOME': '/home/cltbld', 04:57:09 INFO - 'LANG': 'en_US.UTF-8', 04:57:09 INFO - 'LANGUAGE': 'en_US:en', 04:57:09 INFO - 'LOGNAME': 'cltbld', 04:57:09 INFO - 'MAIL': '/var/mail/cltbld', 04:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:09 INFO - 'MOZ_NO_REMOTE': '1', 04:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:09 INFO - 'NO_EM_RESTART': '1', 04:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:09 INFO - 'PWD': '/builds/slave/test', 04:57:09 INFO - 'SHELL': '/bin/bash', 04:57:09 INFO - 'SHLVL': '1', 04:57:09 INFO - 'TERM': 'linux', 04:57:09 INFO - 'TMOUT': '86400', 04:57:09 INFO - 'USER': 'cltbld', 04:57:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:09 INFO - '_': '/tools/buildbot/bin/python'} 04:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:09 INFO - Running setup.py (path:/tmp/pip-CG0r1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:09 INFO - Running setup.py (path:/tmp/pip-QhCSML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:09 INFO - Running setup.py (path:/tmp/pip-kSylTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:09 INFO - Running setup.py (path:/tmp/pip-Jhiz4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:09 INFO - Running setup.py (path:/tmp/pip-El74qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:09 INFO - Running setup.py (path:/tmp/pip-ht1V4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:09 INFO - Running setup.py (path:/tmp/pip-k7GBqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:09 INFO - Running setup.py (path:/tmp/pip-RtxVJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:09 INFO - Running setup.py (path:/tmp/pip-3b62Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:09 INFO - Running setup.py (path:/tmp/pip-phtUdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:10 INFO - Running setup.py (path:/tmp/pip-CMDV4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:10 INFO - Running setup.py (path:/tmp/pip-ypNS5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:10 INFO - Running setup.py (path:/tmp/pip-mi6qcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:10 INFO - Running setup.py (path:/tmp/pip-XDqf4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:10 INFO - Running setup.py (path:/tmp/pip-YGMO1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:10 INFO - Running setup.py (path:/tmp/pip-E4X7ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:10 INFO - Running setup.py (path:/tmp/pip-C3LF4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:10 INFO - Running setup.py install for manifestparser 04:57:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:10 INFO - Running setup.py install for mozcrash 04:57:10 INFO - Running setup.py install for mozdebug 04:57:10 INFO - Running setup.py install for mozdevice 04:57:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:10 INFO - Running setup.py install for mozfile 04:57:11 INFO - Running setup.py install for mozhttpd 04:57:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozinfo 04:57:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozInstall 04:57:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozleak 04:57:11 INFO - Running setup.py install for mozlog 04:57:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for moznetwork 04:57:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozprocess 04:57:11 INFO - Running setup.py install for mozprofile 04:57:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozrunner 04:57:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozscreenshot 04:57:12 INFO - Running setup.py install for moztest 04:57:12 INFO - Running setup.py install for mozversion 04:57:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:12 INFO - Cleaning up... 04:57:12 INFO - Return code: 0 04:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:12 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')]} 04:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:12 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')]} 04:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:12 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:12 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 04:57:12 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 04:57:12 INFO - Using env: {'DISPLAY': ':0', 04:57:12 INFO - 'HOME': '/home/cltbld', 04:57:12 INFO - 'LANG': 'en_US.UTF-8', 04:57:12 INFO - 'LANGUAGE': 'en_US:en', 04:57:12 INFO - 'LOGNAME': 'cltbld', 04:57:12 INFO - 'MAIL': '/var/mail/cltbld', 04:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:12 INFO - 'MOZ_NO_REMOTE': '1', 04:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:12 INFO - 'NO_EM_RESTART': '1', 04:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:12 INFO - 'PWD': '/builds/slave/test', 04:57:12 INFO - 'SHELL': '/bin/bash', 04:57:12 INFO - 'SHLVL': '1', 04:57:12 INFO - 'TERM': 'linux', 04:57:12 INFO - 'TMOUT': '86400', 04:57:12 INFO - 'USER': 'cltbld', 04:57:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:12 INFO - '_': '/tools/buildbot/bin/python'} 04:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:12 INFO - Running setup.py (path:/tmp/pip-3qM8by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:12 INFO - Running setup.py (path:/tmp/pip-SLkbV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:12 INFO - Running setup.py (path:/tmp/pip-7WLHIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:12 INFO - Running setup.py (path:/tmp/pip-I_yIjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:12 INFO - Running setup.py (path:/tmp/pip-nfbSHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:12 INFO - Running setup.py (path:/tmp/pip-m7GENd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:12 INFO - Running setup.py (path:/tmp/pip-bqUqBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:12 INFO - Running setup.py (path:/tmp/pip-oa6hbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:13 INFO - Running setup.py (path:/tmp/pip-j8mBYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:13 INFO - Running setup.py (path:/tmp/pip-PcTeGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:13 INFO - Running setup.py (path:/tmp/pip-ivMldK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:13 INFO - Running setup.py (path:/tmp/pip-kb3rJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:13 INFO - Running setup.py (path:/tmp/pip-TZoqJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:13 INFO - Running setup.py (path:/tmp/pip-JcJ4nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:13 INFO - Running setup.py (path:/tmp/pip-mV4s_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:13 INFO - Running setup.py (path:/tmp/pip-kNGFNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:13 INFO - Running setup.py (path:/tmp/pip-lc1HYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:13 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 04:57:13 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 04:57:13 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 04:57:13 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 04:57:14 INFO - Downloading blessings-1.6.tar.gz 04:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:14 INFO - Installing collected packages: blessings 04:57:14 INFO - Running setup.py install for blessings 04:57:14 INFO - Successfully installed blessings 04:57:14 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:15 INFO - Reading from file tmpfile_stdout 04:57:15 INFO - Current package versions: 04:57:15 INFO - argparse == 1.2.1 04:57:15 INFO - blessings == 1.6 04:57:15 INFO - blobuploader == 1.2.4 04:57:15 INFO - docopt == 0.6.1 04:57:15 INFO - functools32 == 3.2.3-2 04:57:15 INFO - jsonschema == 2.5.1 04:57:15 INFO - manifestparser == 1.1 04:57:15 INFO - mozInstall == 1.13 04:57:15 INFO - mozcrash == 1.0 04:57:15 INFO - mozdebug == 0.1 04:57:15 INFO - mozdevice == 0.51 04:57:15 INFO - mozfile == 1.2 04:57:15 INFO - mozhttpd == 0.7 04:57:15 INFO - mozinfo == 0.10 04:57:15 INFO - mozleak == 0.1 04:57:15 INFO - mozlog == 3.5 04:57:15 INFO - moznetwork == 0.27 04:57:15 INFO - mozprocess == 0.25 04:57:15 INFO - mozprofile == 0.28 04:57:15 INFO - mozrunner == 6.13 04:57:15 INFO - mozscreenshot == 0.1 04:57:15 INFO - mozsystemmonitor == 0.3 04:57:15 INFO - moztest == 0.8 04:57:15 INFO - mozversion == 1.4 04:57:15 INFO - psutil == 3.1.1 04:57:15 INFO - requests == 1.2.3 04:57:15 INFO - wsgiref == 0.1.2 04:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:15 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')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 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')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 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 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57:15 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 04:57:15 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 04:57:15 INFO - Using env: {'DISPLAY': ':0', 04:57:15 INFO - 'HOME': '/home/cltbld', 04:57:15 INFO - 'LANG': 'en_US.UTF-8', 04:57:15 INFO - 'LANGUAGE': 'en_US:en', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MAIL': '/var/mail/cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SHLVL': '1', 04:57:15 INFO - 'TERM': 'linux', 04:57:15 INFO - 'TMOUT': '86400', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - '_': '/tools/buildbot/bin/python'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:57:16 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)) 04:57:16 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)) 04:57:16 INFO - Installing collected packages: simplejson 04:57:16 INFO - Running setup.py install for simplejson 04:57:16 INFO - building 'simplejson._speedups' extension 04:57:16 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 04:57:17 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 04:57:17 INFO - Successfully installed simplejson 04:57:17 INFO - Cleaning up... 04:57:17 INFO - Return code: 0 04:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57: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')]} 04:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, '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': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', '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 04:57: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'] in /builds/slave/test/build 04:57: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 04:57:17 INFO - Using env: {'DISPLAY': ':0', 04:57:17 INFO - 'HOME': '/home/cltbld', 04:57:17 INFO - 'LANG': 'en_US.UTF-8', 04:57:17 INFO - 'LANGUAGE': 'en_US:en', 04:57:17 INFO - 'LOGNAME': 'cltbld', 04:57:17 INFO - 'MAIL': '/var/mail/cltbld', 04:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:17 INFO - 'MOZ_NO_REMOTE': '1', 04:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:17 INFO - 'NO_EM_RESTART': '1', 04:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:17 INFO - 'PWD': '/builds/slave/test', 04:57:17 INFO - 'SHELL': '/bin/bash', 04:57:17 INFO - 'SHLVL': '1', 04:57:17 INFO - 'TERM': 'linux', 04:57:17 INFO - 'TMOUT': '86400', 04:57:17 INFO - 'USER': 'cltbld', 04:57:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:17 INFO - '_': '/tools/buildbot/bin/python'} 04:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:17 INFO - Cleaning up... 04:57:17 INFO - Return code: 0 04:57:17 INFO - Running post-action listener: _resource_record_post_action 04:57:17 INFO - Running post-action listener: _start_resource_monitoring 04:57:17 INFO - Starting resource monitoring. 04:57:17 INFO - [mozharness: 2017-08-25 11:57:17.953670Z] Finished create-virtualenv step (success) 04:57:17 INFO - [mozharness: 2017-08-25 11:57:17.954150Z] Running install step. 04:57:17 INFO - Running pre-action listener: _resource_record_pre_action 04:57:17 INFO - Running main action method: install 04:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:18 INFO - Reading from file tmpfile_stdout 04:57:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:18 INFO - Reading from file tmpfile_stdout 04:57:18 INFO - Output received: 04:57:18 INFO - Usage: mozinstall [options] installer 04:57:18 INFO - Options: 04:57:18 INFO - -h, --help show this help message and exit 04:57:18 INFO - -d DEST, --destination=DEST 04:57:18 INFO - Directory to install application into. [default: 04:57:18 INFO - "/builds/slave/test"] 04:57:18 INFO - --app=APP Application being installed. [default: firefox] 04:57:18 INFO - mkdir: /builds/slave/test/build/application 04:57:18 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'] 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:57:35 INFO - Reading from file tmpfile_stdout 04:57:35 INFO - Output received: 04:57:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:35 INFO - Running post-action listener: _resource_record_post_action 04:57:35 INFO - [mozharness: 2017-08-25 11:57:35.951310Z] Finished install step (success) 04:57:35 INFO - [mozharness: 2017-08-25 11:57:35.951564Z] Running setup-mitmproxy step. 04:57:35 INFO - Running pre-action listener: _resource_record_pre_action 04:57:35 INFO - Running main action method: setup_mitmproxy 04:57:35 INFO - Skipping: mitmproxy is not required 04:57:35 INFO - Running post-action listener: _resource_record_post_action 04:57:35 INFO - [mozharness: 2017-08-25 11:57:35.952677Z] Finished setup-mitmproxy step (success) 04:57:35 INFO - [mozharness: 2017-08-25 11:57:35.952895Z] Running run-tests step. 04:57:35 INFO - Running pre-action listener: _resource_record_pre_action 04:57:35 INFO - Running pre-action listener: _set_gcov_prefix 04:57:35 INFO - Running main action method: run_tests 04:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:35 INFO - Python 2.7.3 04:57:35 INFO - Return code: 0 04:57:35 INFO - grabbing minidump binary from tooltool 04:57:35 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')]} 04:57:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f130>, '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 0x2c70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c704c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:57:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:57:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:57:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:36 INFO - Return code: 0 04:57:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:36 INFO - ENV: RUST_BACKTRACE is now full 04:57:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 04:57:36 INFO - Using env: {'DISPLAY': ':0', 04:57:36 INFO - 'HOME': '/home/cltbld', 04:57:36 INFO - 'LANG': 'en_US.UTF-8', 04:57:36 INFO - 'LANGUAGE': 'en_US:en', 04:57:36 INFO - 'LOGNAME': 'cltbld', 04:57:36 INFO - 'MAIL': '/var/mail/cltbld', 04:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:36 INFO - 'MOZ_NO_REMOTE': '1', 04:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:36 INFO - 'NO_EM_RESTART': '1', 04:57:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:36 INFO - 'PWD': '/builds/slave/test', 04:57:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:36 INFO - 'RUST_BACKTRACE': 'full', 04:57:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:36 INFO - 'SHELL': '/bin/bash', 04:57:36 INFO - 'SHLVL': '1', 04:57:36 INFO - 'TERM': 'linux', 04:57:36 INFO - 'TMOUT': '86400', 04:57:36 INFO - 'USER': 'cltbld', 04:57:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:36 INFO - '_': '/tools/buildbot/bin/python'} 04:57:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:57:36 INFO - mozversion application_buildid: 20170825111222 04:57:36 INFO - mozversion application_changeset: b6b8e616de32af50c9a174006b3a7ed914130aa5 04:57:36 INFO - mozversion application_display_name: Nightly 04:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:36 INFO - mozversion application_name: Firefox 04:57:36 INFO - mozversion application_remotingname: firefox 04:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:36 INFO - mozversion application_vendor: Mozilla 04:57:36 INFO - mozversion application_version: 57.0a1 04:57:36 INFO - mozversion platform_buildid: 20170825111222 04:57:36 INFO - mozversion platform_changeset: b6b8e616de32af50c9a174006b3a7ed914130aa5 04:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:36 INFO - mozversion platform_version: 57.0a1 04:57:36 INFO - using testdate: 1503662256 04:57:36 INFO - actual date: 1503662256 04:57:36 INFO - starting webserver on 'localhost:44362' 04:57:36 INFO - SUITE-START | Running 2 tests 04:57:36 INFO - TEST-START | dromaeo_css 04:57:36 INFO - Initialising browser for dromaeo_css test... 04:57:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44362/getInfo.html -profile /tmp/tmpAQYUEj/profile 04:57:36 INFO - TEST-INFO | started process 16277 (/builds/slave/test/build/application/firefox/firefox http://localhost:44362/getInfo.html) 04:57:43 INFO - TEST-INFO | 16277: exit 0 04:57:43 INFO - Browser initialized. 04:57:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:43 INFO - Using env: {'DISPLAY': ':0', 04:57:43 INFO - 'HOME': '/home/cltbld', 04:57:43 INFO - 'JSGC_DISABLE_POISONING': '1', 04:57:43 INFO - 'LANG': 'en_US.UTF-8', 04:57:43 INFO - 'LANGUAGE': 'en_US:en', 04:57:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MAIL': '/var/mail/cltbld', 04:57:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:43 INFO - 'MOZ_CRASHREPORTER': '1', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test', 04:57:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:43 INFO - 'RUST_BACKTRACE': 'full', 04:57:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SHLVL': '1', 04:57:43 INFO - 'TERM': 'linux', 04:57:43 INFO - 'TMOUT': '86400', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - '_': '/tools/buildbot/bin/python'} 04:57:43 INFO - TEST-INFO | started process 16449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAQYUEj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:44 INFO - PID 16449 | 04:57:44 INFO - PID 16449 | (/builds/slave/test/build/application/firefox/firefox:16499): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:57:44 INFO - PID 16449 | 04:57:44 INFO - PID 16449 | 04:57:44 INFO - PID 16449 | (/builds/slave/test/build/application/firefox/firefox:16552): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:57:44 INFO - PID 16449 | 04:57:45 INFO - PID 16449 | __metrics Screen width/height:1600/1200 04:57:45 INFO - PID 16449 | colorDepth:24 04:57:45 INFO - PID 16449 | Browser inner width/height: 1024/768 04:57:45 INFO - PID 16449 | __metrics 04:57:54 INFO - PID 16449 | RSS: Main: 171749376 04:57:54 INFO - PID 16449 | 05:00:53 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44362/tests/dromaeo/cssquery-ext.html) 05:00:55 INFO - PID 16449 | RSS: Main: 176283648 05:00:55 INFO - PID 16449 | 05:03:56 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-ext.html (next: http://localhost:44362/tests/dromaeo/cssquery-jquery.html) 05:03:57 INFO - PID 16449 | RSS: Main: 171917312 05:03:57 INFO - PID 16449 | 05:06:59 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44362/tests/dromaeo/cssquery-mootools.html) 05:06:59 INFO - PID 16449 | RSS: Main: 174796800 05:06:59 INFO - PID 16449 | 05:10:01 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44362/tests/dromaeo/cssquery-prototype.html) 05:10:02 INFO - PID 16449 | RSS: Main: 172634112 05:10:02 INFO - PID 16449 | 05:13:05 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44362/tests/dromaeo/cssquery-yui.html) 05:13:06 INFO - PID 16449 | RSS: Main: 177500160 05:13:06 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | Cycle 1(1): loaded http://localhost:44362/tests/dromaeo/cssquery-yui.html (next: http://localhost:44362/tests/dromaeo/cssquery-dojo.html) 05:16:08 INFO - PID 16449 | RSS: Main: 177389568 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | __start_tp_report 05:16:08 INFO - PID 16449 | _x_x_mozilla_page_load 05:16:08 INFO - PID 16449 | _x_x_mozilla_page_load_details 05:16:08 INFO - PID 16449 | |i|pagename|runs| 05:16:08 INFO - PID 16449 | |0;dojo.html;3306.223037586168;3314.7348212143024;3318.3529211803693;3342.2479942013065;3349.179451034497;5982.551308651858;6198.070289456584;6258.123862659226;6268.279147897993;6320.715567799449;6118.082287656854;6145.324014358417;6164.229471316085;6168.228971378578;6184.536159788023;5665.8583535411535;5665.8583535411635;5687.175359572881;5692.743826527816;5773.422657734214;5733.713314334287;5740.282464691913;5752.884942301152;5831.271091113611;5864.824055278327;5462.6995515246645;5691.317041954951;5728.828135155952;5778.248827652378;5845.03556913111;5582.190582365575;5688.60179787415;5768.7980920668;5769.855753606152;5774.624649397818;5665.518430933375;5764.827055188351;5766.336871259775;5779.133130030487;5783.421657834225;6195.690215489208;6208.937910620881;6209.658468784215;6225.782097626607;6299.559030867841;6422.26143993442;6543.509236807211;6545.574537655038;6548.574342667712;6732.528722989393;6624.8012559623285;6652.467802575782;6654.334566543307;6655.201375834882;6655.90177620692;6166.753329866845;6168.321484636686;6216.658083805389;6241.469475094668;6246.750129994794;6860.6912688929115;6893.827654308682;6901.068355771907;6915.481338899502;6917.619530925847;6581.539292249592;6585.6377899216;6666.866662666719;6675.899861502081;6694.732210711517;6464.159659244362;6489.286178520359;6636.170478690164;6698.363655452724;6760.391564759196;6665.633390163587;6687.565308255045;6691.26396096429;6691.7323307068145;6709.93290067093;6663.833404164935;6715.630640314732;6759.526833121733;6760.7633732820095;6765.526413151032;5245.711485868237;5256.132738098171;5329.973350133225;5350.5987050971335;5361.919571206435;4547.909041819145;4568.954310456853;4572.337011133367;4653.115907977473;4675.392199014106;5739.081746920473;5745.195672605839;5874.32445268791;5943.64338139713;5948.196993405835;6645.767398141042;6746.426553742888;6757.324267573302;6762.594244345355;6767.1202743644;5806.88386232273;5915.792947246911;5932.0508718604815;5933.6736479493175;5938.8812223755285;5755.0791873300905;5757.136429535603;5843.5325173985975;5845.357010728816;5849.093390524476;6371.394717501737;6508.153939987771;6619.3380661933425;6628.734850606018;6640.136782218281;6564.573302735307;6585.5719378242175;6589.505787066085;6599.9010014848855;6600.9339906602245;6485.513586481127;6489.059086432535;6489.837754056186;6496.545241833026;6499.967500162469;6452.419282264619;6487.578307410004;6531.934680653323;6559.0817285579105;6561.80314590563;6754.0881980931945;6776.45788336922;6821.942598897179;6825.931740682729;6855.006024126574;6478.870422591616;6482.254540727877;6490.643014634241;6590.80227593173;6591.736330546724;6301.905471418024;6397.744090236339;6418.261899881387;6494.6103233806125;6503.414692677682;6300.621962682254;6325.367463253638;6338.746450141943;6365.7135428904885;6374.872502550016;6339;6444.13004244421;6458.934275844433;6488.967555162383;6549.803505894831;6064.4541991221;6234.657093859882;6248.4064013918605;6314.305426403183;6317.747290108528 05:16:08 INFO - PID 16449 | |1;ext.html;778.5406610100043;830.2486249943801;857.7641148684113;862.8490014247506;1103.8951299626542;28682.569761453567;29233.85383073087;37965.81017094911;38806;38834.22331553367;38661.80669096651;39074.41388379176;39085.41371879417;39116.80441597795;39192.804035979854;7457.477976541631;7670.271324224218;7671.079470463525;7676.577788221645;7677.6161191940455;7527.736529221478;7625.923740762604;7630.732924347649;7636.121845987699;7639.656215470317;7620.885686714703;7662.655180516862;7677.884831727529;7704.845903081963;7709.884351734729;7607.885881711779;7638.809029774245;7642.159362470124;7643.159252482223;7645.808854778619;7511.399088072941;7572.507786993828;7575.318221360104;7577.090749110087;7578.8484230315635;34408.13979650529;34437.13907152316;34588.654113459044;34595.827020864985;34603.4809477858;3438.9312213755584;3475.4786781982652;3480.1821571930577;3495.8951231463097;3503.6496350365014;28763;28844.134675959755;28931.56602650941;29056.273593160127;29056.854715726287;4966.503349665005;5101;5118.309028281172;5143.434222235588;5165.199394093921;185008;187134;187236;187328;187707;43696;43749.78125109354;43803;43935.34096988484;44009.339859902124;45972.54027459749;46071.539284606726;46454.535454645695;46494;46545;13176.143550669176;13395;14925.10449373041;15176.468823591122;15184.468543601142;11240.887591123985;11287.435628218556;11293.096552275798;11326.263792853439;11334.829977550344;13170.275634839983;13243;13256.53602123921;13333.866661333457;13383.866161338263;5471;5519.365272993577;5555.583331250173;5688;5697.857553561194;964.840801267797;983.4443539400216;983.9163671088038;1004.6182450668845;1005.7485628592851;20115.39653810388;20571.38285851427;20573.588528229353;20574.382768516967;20990.580188396147;1078.9730256743487;1079.8596182496226;1086.364476781092;1095.4499383372597;1095.9342439453499;11105.278156919774;11113.888861111447;11255.66233013011;11452.770944581061;11571.016463600688;223831;225971;226100;226487;227085;46985.5301446988;47009.5299047012;47352.28971565429;47356.05287894223;47416;1347;1429.6640289531952;1435.4617018618228;1438.079629037417;1444.609955312081;20149;20286.89856550708;20455.28406505765;25883.223503294932;26728;46017.53982460133;46086.30870537012;46155;46164.307535386324;46221.30668040049;198427;198498;198586;198675;199188;31505.684943150274;31605.5259171108;32436.837815811716;32919.67080329166;32940.835295823366;40880.79559602302;42403.363949540166;42564.787176063925;42732.78633606937;42763.572364277206;31472.842635786674;31841.840790795897;31977.200569985005;32231;32356.838215809712;31224.843875780476;31619.36761264808;32018.67981320157;32096.67903320937;32200.19499512531;33924.15189620279;34749.13127171841;34983.825080874434;35037.649623503436;35063.64936350604;30731.846340768152;30780;30942.845285773426;31043.37913241768;31358.52962205523;22853.20013799509;23121.768782311963;23220.419489512897;23674.881625591763;24155.275341739776 05:16:08 INFO - PID 16449 | |2;jquery.html;542.8235823357408;553.3194171169464;555.2537270284954;556.1518684006892;567.409893710541;21091.367258982234;21740.89129554352;21834;21866.23468178614;22429.102835886544;23754.76245237547;24177.153799617015;24263.514729705395;24310.906009229584;24373.634395484038;6515.283318834936;6623.73505059797;6624.900626490607;6625.569337993015;6631.204255489348;6027.457528822405;6540.34596540347;6567.868642627144;6577.769778057769;6578.60528368297;6524.4454221391;6525.053867189255;6527.379898909619;6529.085927970064;6545.410913017828;6468.967655161718;6469.061986012049;6469.159009328804;6472.158619379474;6472.417482426557;6043.697815109227;6056.606320589148;6068.726907289182;6073.301570319381;6077.878442431127;27934.720652793618;28713.56929646057;29182;29239.85380073086;29315.267118322;1702.285040283084;1729.2218501674297;1731.8268173182707;1733.7139372003605;1735.210479231959;19147.425577232567;19408.4177474676;19446.51383715404;19754.802451975585;20687;2538.708048574419;2543.224316583441;2595.286296268522;2641.141628970592;2648.046703186851;140470.29764851212;144072;146589;147441.26279368642;147480.26259868633;19923;20710.896445517676;20721.58556828855;21226.726396415954;22172.223972160897;41087.7945610276;41149.38275925864;41171.58828411737;41210.587894120676;41272;11233.55065797359;11505.597304094317;11548.884511154782;11551.422428878523;11632.185746997799;7866.606669666494;8262.586870656563;9544.42733435996;9609.183219426288;9726.805463890683;10747.78504429907;10793.78412431747;11087.279326843729;11226.719332016764;11331.376774277329;3551.893443196708;3556.76881002734;3796.6962642989047;4052.9594704052583;4110.671146308288;919.5586118662945;942.7784470649392;943.2265542255421;951.8048799996122;952.0907533305676;17979.910100449677;18187;23657;23721.406964826016;24733.2580022596;1018.607835983137;1023.3808545829665;1028.665683652816;1029.0789743179812;1034.0590063042596;10706.503268627195;10887.618933337295;11024.944875275733;11084.334939903632;11107.333559986266;459925;475027;515348;517579;525447;112480;120305;122814.3859280698;124443;125326;1181.4447209811374;1210.2798834693344;1238.4550797649185;1243.2354102227066;1243.6704273367566;21362.893185533972;21435.78564214338;21453.14187432485;21504.462388440414;21783.564328713655;62912.37087629065;63711.362886370545;64044;64977.35022649713;65747;81342;81915;82489;84268;85491;21143.154273828874;21219.7878021224;21712;21727.782722172575;21944.780552194912;23489.295321140395;24152.87923560371;24263.75736242615;24312.27063188107;24372.390690232885;17768.378106766202;18346.54133646616;18463.261469541067;18490.44528664142;18532.536686582403;16645.83354166443;16928.15359232058;17142.485725428258;17170.141492925555;17947.461576152735;18255.90872045631;18669.71995420097;18737.906310468905;18768.155433005275;18769.249230031193;20011.299604513773;21202.15191392327;21260;21295.78704212938;21300.7869921305;18150.818491814913;18335.81664183341;18337.541561461072;18375.356862509747;18401.63196736031 05:16:08 INFO - PID 16449 | |3;mootools.html;1252.9874701252988;1321.6497628128548;1333.5465941579862;1336.1648969394125;1340.7318536292737;14153.15081095135;14717.558473245806;15269.618259543517;15289.770653440208;15306;14918.552443426715;15132.924335378335;15205.23973801311;15226.847731522681;15242.237888105577;2602.297379707478;2661.813673042888;2721.047633328339;2727.8543011934935;2737.20621019904;2726.509228338898;2731.5356389413746;2781.2490627530556;2782.3183320086605;2783.7216278372202;2642.445086531831;2688.784897208219;2712;2713.036871910473;2714.4435390744948;2607.58278675411;2626.986865065672;2660.175345642838;2666.080202330193;2670.3324168957856;2571.2029270926073;2609.3607066268696;2611.4385407137365;2612.3991481959256;2647.5234457797587;14367;14466.493672721404;14473.565793026226;14476;14489.058211216237;7717.768466946;8034.116247212802;8041.95979020107;8043.235892590194;8052.59737013147;5265.262863199156;5490.533304669108;5586.24585680932;5606.327240731098;5623.044082505943;1869.2896699254331;1880.2854915132161;1906.8760530565469;1934.3133187718297;1946.3674305850654;24139.758602413927;24656.506869862504;24852.50294994108;24861.87569062161;24877.253682389557;6944.652767361612;6955.374016338554;6978.616176110261;7118.145822501333;7120.928790712027;19133.425997220107;19167;19173.90413047926;19185.808141918682;19189.520261993282;7403.51877127985;7493;7625.351845093118;7649.196834332315;7673.040869891263;6784.728610855511;6873.656317184121;6912.619805910723;6919.930800692029;6939.75710850128;5074.898502030012;5191.6884986900905;5214.374275087014;5242.1088414969545;5242.501962313574;1469.8530146985215;1477.0546850015999;1477.4016523307862;1485.6434455730546;1492.276246020679;838.2832678060171;854.2525290370926;860.6772460327377;863.749512641327;874.61079819481;6869.175698916062;6902.792916212522;6936.7225310987;6970.024196612479;7007.369336759614;679.3647939176885;679.6092246958019;685.348918527401;692.5394612582677;698.7135274537416;4542.545745425497;4952.653314268039;5029.597632189416;5030.974845125751;5054.646174767731;20272.797272027092;20381;21151.576968460544;21374.465638359165;21433.142674292852;20782.896085519475;20854.687179692315;20870.895645521676;20878.060487278108;21037;10009.449480278654;10456.790864182674;10561.471926403648;10615;10618;8279.751607451786;8388.832223355377;8655.221030107321;8824.3381746368;9071.546422678708;17204.827951720323;17554.473365799047;17569.648607028044;17786.644267114843;18173.636527269646;17673.82326176773;17771.822281777535;18057.458276251735;18628.254869805056;18748.343807966656;13214;13540.390682419118;13541;13547.525836595672;13568.525101621395;13261.734765304833;13494.190348579117;13595.252261125337;13603.659908502366;13619.659508512366;10855.2401331906;10920.617778378037;11014.779704406028;11114.110871130451;11232.66302010941;10480.528376222936;10539.104176145114;10708.571657133627;11041.227114101936;11191.944040279746;9037.95481022617;9041.23149532297;9079.364444489087;9140.497272649802;9168.495732734764;7201.387882030086;7257.673404696907;7266.237045110187;7318.048653674989;7334.083239595051;7033.261507541839;7078.8938165928585;7219.891701624375;7221.458390620619;7275.126984761862 05:16:08 INFO - PID 16449 | |4;prototype.html;495.44231774109267;508.2554058304584;514.1721827857149;518.8261932252695;527.4330095147717;6232.314445411007;6257.124002639634;6293;6310.936890631092;6344.637342208631;5991.281046274442;6088.969555152218;6270.27891792444;6276.717547710353;6277.950721784447;5149.17613181891;5198.376194856613;5201.479852014806;5204.579870360281;5267.130923397634;5070.315507406508;5202.791888324463;5278.498542638443;5284;5292.259083728281;5171.896562068757;5202.297689811884;5219.71291578963;5259.658122222062;5288.101022826128;5173.974130129344;5173.974130129344;5218.817341393071;5223.921641175385;5224.895502089975;4845.927311090337;4853.174960256765;4857.465678775332;4862.683925544864;4875.829345972874;6180.48824358221;6198.3801619838105;6232.844178895564;6270.09083682868;6299.8740025199695;6031.336552979169;6075.7873474428625;6107.358727333655;6113.663748493831;6123.357047509992;6650.567713098633;6654.401103900624;6691.330866913269;6754.662266886636;6783.116156367408;5295.523402893758;5325.920111198335;5335.839924802262;5364.946350536484;5387.572293342268;7022.578645281299;7050;7082.5396349237135;7127.964360178218;7129.928700712979;5527.093152862256;5530.944690553123;5545.916811247835;5547.805826796042;5552.805651802168;5607.130894711327;5613.494785469327;5642.915356269659;5646.153077038477;5650.9263239984275;5996.220491336098;6083.866808593578;6116.235470566179;6129.233845769279;6139.969300153471;6711.496637752188;6718.899216511756;6753.392194702402;6758.222804377461;6784.287649796799;1844.5019844641872;1866.5893503429224;1911.961760764777;1936.206155476248;1954.6090781843689;1433.8207724034496;1444.732724445981;1447.7249322628668;1453.382312517176;1464.8535146485267;5857.648541087463;5892.351841297454;5894.263217097863;5907.438793314628;5922.970385148046;6626.701798418986;6813.863722725518;6826.795196144124;6846.261495401879;6883.931160688429;5894.145348924468;5904.291485021825;5937.376575459514;5958.6424814511265;5970.253718285215;3559.982200089035;3575.4636804479014;3607.3867442534834;3622.5471816022996;3643.143861192618;6709.161354830646;6721.428678562279;6738.561993470409;6761.425278851254;6780.93219067803;6973.686184121727;6986.336298051677;6989.720411183597;7042.964785176041;7063.505554611128;6612.537122401386;6662.766803161866;6733;6741.157355330583;6775.288594697486;6660.368209788633;6704.564203326768;6793.724102425545;6874.346937040973;6898.965505172442;6641.535092543476;6736.360045795642;6759.797206083826;6760;6770.086038384755;6617.37874220819;6632.015592983081;6637.1703537057865;6650.634215118215;6660.300668429939;4936.062148191832;4973.229149481836;5005.34930459038;5011.248312753116;5054.519820617035;6608.372204640552;6739.730410783513;6776.186857577122;6904.620245886525;6917;6378.394052564999;6602.240742314503;6606.174228221473;6629.801105966829;6643.60138391698;6574.8356291093105;6593.835154121185;6600.60396376219;6611.834704132243;6628.436582890508;6383.553151279366;6528.714949767544;6555.475561954937;6556.8360790978695;6610.8347291318105;6660.83435398813;6664.866702665822;6688.398044176048;6693.9624358224555;6696.531242812956;6413.743450261937;6417.839554011187;6448.422608938949;6476.514261430506;6499.122618446449 05:16:08 INFO - PID 16449 | |5;yui.html;867.8481265778487;884.3500027479803;897.0401670212875;898.8157427727313;902.147470640245;18589.907050464746;19367.418977430665;19559.826410415368;19677.409677709657;20987.895060524716;18779.62440751184;18799.81200187998;18862;18866.528336791554;18887.527811804714;838.5262326785378;923.8752768376283;942.1520631431698;944.2446043165475;957.1051067252107;846.5090247656344;846.9110743371949;848.1052489623476;848.495145388496;848.7708318753932;952.8332541805191;982.2633025231077;990.2721499697752;994.1102713071797;999.6601155607092;974.488393593362;981.1709105805619;981.6367943860818;981.66623348062;982.2583949118441;714.653393104344;716.8207948012997;719.0149495191569;719.2663483247059;719.3885197582066;18215.908920455444;18517.166727497293;18648.347307844295;18815.435536933914;19808.504787380287;20504.487387815276;20663.79336206634;20773.480662983395;21169.47076323089;21171.364859054098;16960.40638577656;17187.312507499686;17449.476515704548;17487.82512174875;17518.91240543789;3669.9266014679824;3679.5952445231005;3693.778373297584;3703.4259689748133;3704.073981504624;129292.3535382317;129467.35266323702;132898;132989;133091.33454332763;16218.270177842025;16626.58433539171;16672.58318542022;16827.57931051709;16919;30051.69948300489;30447.695523044928;30614.611132767564;30725;30781.076567703003;8468.49189048659;8576.785580360542;8596.312295016383;8597.26923211534;8607.139286071468;3693.538307711536;3864.497615310048;4198.244316023145;4332.1985432695055;4358.978205108954;5026.547610715053;5162.9741851291255;5164.741762911839;5165.14775062118;5167.276581278624;1077.4289626497969;1089.1069323154936;1100.1748688483638;1138.1463902073444;1145.4330106597288;664.4186336955164;676.47573130824;692.7679227458757;693.9063226464464;699.1086364884711;10890.821835632747;11058.281211721212;11365.261258018203;11391.316521008766;11850.11124165691;680.0750978669006;682.0928165539821;690.3338278561213;694.2432748304373;694.6908625661532;5503.532199763065;5664.320281566238;5680.77276908919;5713.714314284269;5830.650160990354;104862;105887.47056264823;106395;108396;110219.89780102097;90606;91482;91745.08254917499;93425;94427;82560;83165;85107;86239;87996.12003880007;10169.389836609827;10319.019693129141;10369.429681367597;10401.375917444977;10663.94668026686;39148.80425597854;40535.797321013204;41290;41964.580354197285;41965.370519441625;70514.64742676253;73498;73622.26377736368;73790;75461.24538754762;17824.732629010316;18759.34342298013;18847.434576962714;18883.433496995112;19411.126499307284;18500.612454066268;18752.437426877215;20239.59520809546;20252.696209556572;20493;16219.756703649691;16319;16473.423430179886;16656.666866662355;17230.655386892442;17076.829231707525;19554.902225488782;19989.800101998793;20023.399298021082;20105.19579216815;17214.913925430294;17500.474985750447;17571.824281757017;17820.10899455048;17896.821031790038;12349.506019759468;12572.685682858002;12883.80674289905;13167.2757998311;13367.131136476099;14326.785098223327;14360.784588231394;14518.564443066725;14530.273486325852;14575.781363279348 05:16:08 INFO - PID 16449 | __end_tp_report 05:16:08 INFO - PID 16449 | __start_cc_report 05:16:08 INFO - PID 16449 | _x_x_mozilla_cycle_collect,385 05:16:08 INFO - PID 16449 | __end_cc_report 05:16:08 INFO - PID 16449 | __startTimestamp1503663368474__endTimestamp 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | ------- Summary: start ------- 05:16:08 INFO - PID 16449 | Number of tests: 6 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#0] dojo.html Cycles:165 Average:6142.70 Median:6325.37 stddev:701.90 (11.1%) stddev-sans-first:667.85 05:16:08 INFO - PID 16449 | Values: 3306.2 3314.7 3318.4 3342.2 3349.2 5982.6 6198.1 6258.1 6268.3 6320.7 6118.1 6145.3 6164.2 6168.2 6184.5 5665.9 5665.9 5687.2 5692.7 5773.4 5733.7 5740.3 5752.9 5831.3 5864.8 5462.7 5691.3 5728.8 5778.2 5845.0 5582.2 5688.6 5768.8 5769.9 5774.6 5665.5 5764.8 5766.3 5779.1 5783.4 6195.7 6208.9 6209.7 6225.8 6299.6 6422.3 6543.5 6545.6 6548.6 6732.5 6624.8 6652.5 6654.3 6655.2 6655.9 6166.8 6168.3 6216.7 6241.5 6246.8 6860.7 6893.8 6901.1 6915.5 6917.6 6581.5 6585.6 6666.9 6675.9 6694.7 6464.2 6489.3 6636.2 6698.4 6760.4 6665.6 6687.6 6691.3 6691.7 6709.9 6663.8 6715.6 6759.5 6760.8 6765.5 5245.7 5256.1 5330.0 5350.6 5361.9 4547.9 4569.0 4572.3 4653.1 4675.4 5739.1 5745.2 5874.3 5943.6 5948.2 6645.8 6746.4 6757.3 6762.6 6767.1 5806.9 5915.8 5932.1 5933.7 5938.9 5755.1 5757.1 5843.5 5845.4 5849.1 6371.4 6508.2 6619.3 6628.7 6640.1 6564.6 6585.6 6589.5 6599.9 6600.9 6485.5 6489.1 6489.8 6496.5 6500.0 6452.4 6487.6 6531.9 6559.1 6561.8 6754.1 6776.5 6821.9 6825.9 6855.0 6478.9 6482.3 6490.6 6590.8 6591.7 6301.9 6397.7 6418.3 6494.6 6503.4 6300.6 6325.4 6338.7 6365.7 6374.9 6339.0 6444.1 6458.9 6489.0 6549.8 6064.5 6234.7 6248.4 6314.3 6317.7 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#1] ext.html Cycles:180 Average:36383.29 Median:18681.54 stddev:52985.54 (283.6%) stddev-sans-first:53066.74 05:16:08 INFO - PID 16449 | Values: 778.5 830.2 857.8 862.8 1103.9 28682.6 29233.9 37965.8 38806.0 38834.2 38661.8 39074.4 39085.4 39116.8 39192.8 7457.5 7670.3 7671.1 7676.6 7677.6 7527.7 7625.9 7630.7 7636.1 7639.7 7620.9 7662.7 7677.9 7704.8 7709.9 7607.9 7638.8 7642.2 7643.2 7645.8 7511.4 7572.5 7575.3 7577.1 7578.8 34408.1 34437.1 34588.7 34595.8 34603.5 3438.9 3475.5 3480.2 3495.9 3503.6 28763.0 28844.1 28931.6 29056.3 29056.9 4966.5 5101.0 5118.3 5143.4 5165.2 185008.0 187134.0 187236.0 187328.0 187707.0 43696.0 43749.8 43803.0 43935.3 44009.3 45972.5 46071.5 46454.5 46494.0 46545.0 13176.1 13395.0 14925.1 15176.5 15184.5 11240.9 11287.4 11293.1 11326.3 11334.8 13170.3 13243.0 13256.5 13333.9 13383.9 5471.0 5519.4 5555.6 5688.0 5697.9 964.8 983.4 983.9 1004.6 1005.7 20115.4 20571.4 20573.6 20574.4 20990.6 1079.0 1079.9 1086.4 1095.4 1095.9 11105.3 11113.9 11255.7 11452.8 11571.0 223831.0 225971.0 226100.0 226487.0 227085.0 46985.5 47009.5 47352.3 47356.1 47416.0 1347.0 1429.7 1435.5 1438.1 1444.6 20149.0 20286.9 20455.3 25883.2 26728.0 46017.5 46086.3 46155.0 46164.3 46221.3 198427.0 198498.0 198586.0 198675.0 199188.0 31505.7 31605.5 32436.8 32919.7 32940.8 40880.8 42403.4 42564.8 42732.8 42763.6 31472.8 31841.8 31977.2 32231.0 32356.8 31224.8 31619.4 32018.7 32096.7 32200.2 33924.2 34749.1 34983.8 35037.6 35063.6 30731.8 30780.0 30942.8 31043.4 31358.5 22853.2 23121.8 23220.4 23674.9 24155.3 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#2] jquery.html Cycles:180 Average:37160.79 Median:22300.66 stddev:84446.95 (378.7%) stddev-sans-first:84639.09 05:16:08 INFO - PID 16449 | Values: 542.8 553.3 555.3 556.2 567.4 21091.4 21740.9 21834.0 21866.2 22429.1 23754.8 24177.2 24263.5 24310.9 24373.6 6515.3 6623.7 6624.9 6625.6 6631.2 6027.5 6540.3 6567.9 6577.8 6578.6 6524.4 6525.1 6527.4 6529.1 6545.4 6469.0 6469.1 6469.2 6472.2 6472.4 6043.7 6056.6 6068.7 6073.3 6077.9 27934.7 28713.6 29182.0 29239.9 29315.3 1702.3 1729.2 1731.8 1733.7 1735.2 19147.4 19408.4 19446.5 19754.8 20687.0 2538.7 2543.2 2595.3 2641.1 2648.0 140470.3 144072.0 146589.0 147441.3 147480.3 19923.0 20710.9 20721.6 21226.7 22172.2 41087.8 41149.4 41171.6 41210.6 41272.0 11233.6 11505.6 11548.9 11551.4 11632.2 7866.6 8262.6 9544.4 9609.2 9726.8 10747.8 10793.8 11087.3 11226.7 11331.4 3551.9 3556.8 3796.7 4053.0 4110.7 919.6 942.8 943.2 951.8 952.1 17979.9 18187.0 23657.0 23721.4 24733.3 1018.6 1023.4 1028.7 1029.1 1034.1 10706.5 10887.6 11024.9 11084.3 11107.3 459925.0 475027.0 515348.0 517579.0 525447.0 112480.0 120305.0 122814.4 124443.0 125326.0 1181.4 1210.3 1238.5 1243.2 1243.7 21362.9 21435.8 21453.1 21504.5 21783.6 62912.4 63711.4 64044.0 64977.4 65747.0 81342.0 81915.0 82489.0 84268.0 85491.0 21143.2 21219.8 21712.0 21727.8 21944.8 23489.3 24152.9 24263.8 24312.3 24372.4 17768.4 18346.5 18463.3 18490.4 18532.5 16645.8 16928.2 17142.5 17170.1 17947.5 18255.9 18669.7 18737.9 18768.2 18769.2 20011.3 21202.2 21260.0 21295.8 21300.8 18150.8 18335.8 18337.5 18375.4 18401.6 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#3] mootools.html Cycles:180 Average:9143.29 Median:2619.69 stddev:6497.72 (248.0%) stddev-sans-first:6488.90 05:16:08 INFO - PID 16449 | Values: 1253.0 1321.6 1333.5 1336.2 1340.7 14153.2 14717.6 15269.6 15289.8 15306.0 14918.6 15132.9 15205.2 15226.8 15242.2 2602.3 2661.8 2721.0 2727.9 2737.2 2726.5 2731.5 2781.2 2782.3 2783.7 2642.4 2688.8 2712.0 2713.0 2714.4 2607.6 2627.0 2660.2 2666.1 2670.3 2571.2 2609.4 2611.4 2612.4 2647.5 14367.0 14466.5 14473.6 14476.0 14489.1 7717.8 8034.1 8042.0 8043.2 8052.6 5265.3 5490.5 5586.2 5606.3 5623.0 1869.3 1880.3 1906.9 1934.3 1946.4 24139.8 24656.5 24852.5 24861.9 24877.3 6944.7 6955.4 6978.6 7118.1 7120.9 19133.4 19167.0 19173.9 19185.8 19189.5 7403.5 7493.0 7625.4 7649.2 7673.0 6784.7 6873.7 6912.6 6919.9 6939.8 5074.9 5191.7 5214.4 5242.1 5242.5 1469.9 1477.1 1477.4 1485.6 1492.3 838.3 854.3 860.7 863.7 874.6 6869.2 6902.8 6936.7 6970.0 7007.4 679.4 679.6 685.3 692.5 698.7 4542.5 4952.7 5029.6 5031.0 5054.6 20272.8 20381.0 21151.6 21374.5 21433.1 20782.9 20854.7 20870.9 20878.1 21037.0 10009.4 10456.8 10561.5 10615.0 10618.0 8279.8 8388.8 8655.2 8824.3 9071.5 17204.8 17554.5 17569.6 17786.6 18173.6 17673.8 17771.8 18057.5 18628.3 18748.3 13214.0 13540.4 13541.0 13547.5 13568.5 13261.7 13494.2 13595.3 13603.7 13619.7 10855.2 10920.6 11014.8 11114.1 11232.7 10480.5 10539.1 10708.6 11041.2 11191.9 9038.0 9041.2 9079.4 9140.5 9168.5 7201.4 7257.7 7266.2 7318.0 7334.1 7033.3 7078.9 7219.9 7221.5 7275.1 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#4] prototype.html Cycles:180 Average:5694.11 Median:6244.98 stddev:1537.32 (24.6%) stddev-sans-first:1491.29 05:16:08 INFO - PID 16449 | Values: 495.4 508.3 514.2 518.8 527.4 6232.3 6257.1 6293.0 6310.9 6344.6 5991.3 6089.0 6270.3 6276.7 6278.0 5149.2 5198.4 5201.5 5204.6 5267.1 5070.3 5202.8 5278.5 5284.0 5292.3 5171.9 5202.3 5219.7 5259.7 5288.1 5174.0 5174.0 5218.8 5223.9 5224.9 4845.9 4853.2 4857.5 4862.7 4875.8 6180.5 6198.4 6232.8 6270.1 6299.9 6031.3 6075.8 6107.4 6113.7 6123.4 6650.6 6654.4 6691.3 6754.7 6783.1 5295.5 5325.9 5335.8 5364.9 5387.6 7022.6 7050.0 7082.5 7128.0 7129.9 5527.1 5530.9 5545.9 5547.8 5552.8 5607.1 5613.5 5642.9 5646.2 5650.9 5996.2 6083.9 6116.2 6129.2 6140.0 6711.5 6718.9 6753.4 6758.2 6784.3 1844.5 1866.6 1912.0 1936.2 1954.6 1433.8 1444.7 1447.7 1453.4 1464.9 5857.6 5892.4 5894.3 5907.4 5923.0 6626.7 6813.9 6826.8 6846.3 6883.9 5894.1 5904.3 5937.4 5958.6 5970.3 3560.0 3575.5 3607.4 3622.5 3643.1 6709.2 6721.4 6738.6 6761.4 6780.9 6973.7 6986.3 6989.7 7043.0 7063.5 6612.5 6662.8 6733.0 6741.2 6775.3 6660.4 6704.6 6793.7 6874.3 6899.0 6641.5 6736.4 6759.8 6760.0 6770.1 6617.4 6632.0 6637.2 6650.6 6660.3 4936.1 4973.2 5005.3 5011.2 5054.5 6608.4 6739.7 6776.2 6904.6 6917.0 6378.4 6602.2 6606.2 6629.8 6643.6 6574.8 6593.8 6600.6 6611.8 6628.4 6383.6 6528.7 6555.5 6556.8 6610.8 6660.8 6664.9 6688.4 6694.0 6696.5 6413.7 6417.8 6448.4 6476.5 6499.1 05:16:08 INFO - PID 16449 | 05:16:08 INFO - PID 16449 | [#5] yui.html Cycles:180 Average:23582.73 Median:30249.70 stddev:32199.20 (106.4%) stddev-sans-first:32244.35 05:16:08 INFO - PID 16449 | Values: 867.8 884.4 897.0 898.8 902.1 18589.9 19367.4 19559.8 19677.4 20987.9 18779.6 18799.8 18862.0 18866.5 18887.5 838.5 923.9 942.2 944.2 957.1 846.5 846.9 848.1 848.5 848.8 952.8 982.3 990.3 994.1 999.7 974.5 981.2 981.6 981.7 982.3 714.7 716.8 719.0 719.3 719.4 18215.9 18517.2 18648.3 18815.4 19808.5 20504.5 20663.8 20773.5 21169.5 21171.4 16960.4 17187.3 17449.5 17487.8 17518.9 3669.9 3679.6 3693.8 3703.4 3704.1 129292.4 129467.4 132898.0 132989.0 133091.3 16218.3 16626.6 16672.6 16827.6 16919.0 30051.7 30447.7 30614.6 30725.0 30781.1 8468.5 8576.8 8596.3 8597.3 8607.1 3693.5 3864.5 4198.2 4332.2 4359.0 5026.5 5163.0 5164.7 5165.1 5167.3 1077.4 1089.1 1100.2 1138.1 1145.4 664.4 676.5 692.8 693.9 699.1 10890.8 11058.3 11365.3 11391.3 11850.1 680.1 682.1 690.3 694.2 694.7 5503.5 5664.3 5680.8 5713.7 5830.7 104862.0 105887.5 106395.0 108396.0 110219.9 90606.0 91482.0 91745.1 93425.0 94427.0 82560.0 83165.0 85107.0 86239.0 87996.1 10169.4 10319.0 10369.4 10401.4 10663.9 39148.8 40535.8 41290.0 41964.6 41965.4 70514.6 73498.0 73622.3 73790.0 75461.2 17824.7 18759.3 18847.4 18883.4 19411.1 18500.6 18752.4 20239.6 20252.7 20493.0 16219.8 16319.0 16473.4 16656.7 17230.7 17076.8 19554.9 19989.8 20023.4 20105.2 17214.9 17500.5 17571.8 17820.1 17896.8 12349.5 12572.7 12883.8 13167.3 13367.1 14326.8 14360.8 14518.6 14530.3 14575.8 05:16:08 INFO - PID 16449 | -------- Summary: end -------- 05:16:08 INFO - PID 16449 | 05:16:09 INFO - TEST-INFO | 16449: exit 0 05:16:09 INFO - TEST-OK | dromaeo_css | took 1112913ms 05:16:09 INFO - TEST-START | kraken 05:16:09 INFO - Initialising browser for kraken test... 05:16:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44362/getInfo.html -profile /tmp/tmpdHBqM_/profile 05:16:09 INFO - TEST-INFO | started process 16857 (/builds/slave/test/build/application/firefox/firefox http://localhost:44362/getInfo.html) 05:16:15 INFO - TEST-INFO | 16857: exit 0 05:16:15 INFO - Browser initialized. 05:16:15 INFO - Running cycle 1/1 for kraken test... 05:16:15 INFO - Using env: {'DISPLAY': ':0', 05:16:15 INFO - 'HOME': '/home/cltbld', 05:16:15 INFO - 'JSGC_DISABLE_POISONING': '1', 05:16:15 INFO - 'LANG': 'en_US.UTF-8', 05:16:15 INFO - 'LANGUAGE': 'en_US:en', 05:16:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MAIL': '/var/mail/cltbld', 05:16:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:15 INFO - 'MOZ_CRASHREPORTER': '1', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:15 INFO - 'RUST_BACKTRACE': 'full', 05:16:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SHLVL': '1', 05:16:15 INFO - 'TERM': 'linux', 05:16:15 INFO - 'TMOUT': '86400', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - '_': '/tools/buildbot/bin/python'} 05:16:15 INFO - TEST-INFO | started process 17031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdHBqM_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:16 INFO - PID 17031 | 05:16:16 INFO - PID 17031 | (/builds/slave/test/build/application/firefox/firefox:17080): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:16 INFO - PID 17031 | 05:16:17 INFO - PID 17031 | 05:16:17 INFO - PID 17031 | (/builds/slave/test/build/application/firefox/firefox:17136): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:17 INFO - PID 17031 | 05:16:17 INFO - PID 17031 | __metrics Screen width/height:1600/1200 05:16:17 INFO - PID 17031 | colorDepth:24 05:16:17 INFO - PID 17031 | Browser inner width/height: 1024/768 05:16:17 INFO - PID 17031 | __metrics 05:16:26 INFO - PID 17031 | RSS: Main: 172032000 05:16:26 INFO - PID 17031 | 05:16:29 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:30 INFO - PID 17031 | RSS: Main: 176484352 05:16:30 INFO - PID 17031 | 05:16:33 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-dft) 05:16:33 INFO - PID 17031 | RSS: Main: 176590848 05:16:33 INFO - PID 17031 | 05:16:36 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-fft) 05:16:37 INFO - PID 17031 | RSS: Main: 171089920 05:16:37 INFO - PID 17031 | 05:16:39 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44362/tests/kraken/driver.html?testName=audio-oscillator) 05:16:40 INFO - PID 17031 | RSS: Main: 172011520 05:16:40 INFO - PID 17031 | 05:16:42 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:42 INFO - PID 17031 | RSS: Main: 172290048 05:16:42 INFO - PID 17031 | 05:16:45 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:46 INFO - PID 17031 | RSS: Main: 173309952 05:16:46 INFO - PID 17031 | 05:16:50 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44362/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:50 INFO - PID 17031 | RSS: Main: 172998656 05:16:50 INFO - PID 17031 | 05:16:53 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44362/tests/kraken/driver.html?testName=json-parse-financial) 05:16:54 INFO - PID 17031 | RSS: Main: 174284800 05:16:54 INFO - PID 17031 | 05:16:55 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:56 INFO - PID 17031 | RSS: Main: 173637632 05:16:56 INFO - PID 17031 | 05:16:58 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:58 INFO - PID 17031 | RSS: Main: 174010368 05:16:58 INFO - PID 17031 | 05:17:00 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:01 INFO - PID 17031 | RSS: Main: 173654016 05:17:01 INFO - PID 17031 | 05:17:04 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:04 INFO - PID 17031 | RSS: Main: 174067712 05:17:04 INFO - PID 17031 | 05:17:07 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:08 INFO - PID 17031 | RSS: Main: 174194688 05:17:08 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | Cycle 1(1): loaded http://localhost:44362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44362/tests/kraken/driver.html?testName=ai-astar) 05:17:10 INFO - PID 17031 | RSS: Main: 175960064 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | __start_tp_report 05:17:10 INFO - PID 17031 | _x_x_mozilla_page_load 05:17:10 INFO - PID 17031 | _x_x_mozilla_page_load_details 05:17:10 INFO - PID 17031 | |i|pagename|runs| 05:17:10 INFO - PID 17031 | |0;ai-astar;100;106;99;106;106;112;108;99;108;108 05:17:10 INFO - PID 17031 | |1;audio-beat-detection;143;120;155;181;116;162;148;118;176;121 05:17:10 INFO - PID 17031 | |2;audio-dft;162;163;161;162;162;162;163;166;166;168 05:17:10 INFO - PID 17031 | |3;audio-fft;73;74;76;165;74;74;75;73;153;75 05:17:10 INFO - PID 17031 | |4;audio-oscillator;79;80;135;79;79;79;134;79;79;125 05:17:10 INFO - PID 17031 | |5;imaging-gaussian-blur;114;114;113;114;113;114;114;114;114;114 05:17:10 INFO - PID 17031 | |6;imaging-darkroom;154;148;149;147;151;148;148;147;149;150 05:17:10 INFO - PID 17031 | |7;imaging-desaturate;94;94;94;98;94;94;95;94;94;93 05:17:10 INFO - PID 17031 | |8;json-parse-financial;52;52;51;51;54;52;51;52;52;53 05:17:10 INFO - PID 17031 | |9;json-stringify-tinderbox;55;55;56;55;55;55;55;56;55;56 05:17:10 INFO - PID 17031 | |10;stanford-crypto-aes;74;76;75;77;75;75;80;74;74;73 05:17:10 INFO - PID 17031 | |11;stanford-crypto-ccm;127;116;120;126;117;122;121;123;124;162 05:17:10 INFO - PID 17031 | |12;stanford-crypto-pbkdf2;184;191;181;178;178;173;171;177;172;171 05:17:10 INFO - PID 17031 | |13;stanford-crypto-sha256-iterative;66;64;65;65;65;63;64;65;66;63 05:17:10 INFO - PID 17031 | __end_tp_report 05:17:10 INFO - PID 17031 | __start_cc_report 05:17:10 INFO - PID 17031 | _x_x_mozilla_cycle_collect,917 05:17:10 INFO - PID 17031 | __end_cc_report 05:17:10 INFO - PID 17031 | __startTimestamp1503663430565__endTimestamp 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | ------- Summary: start ------- 05:17:10 INFO - PID 17031 | Number of tests: 14 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.00 stddev:4.42 (4.1%) stddev-sans-first:4.27 05:17:10 INFO - PID 17031 | Values: 100.0 106.0 99.0 106.0 106.0 112.0 108.0 99.0 108.0 108.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.50 stddev:24.54 (16.2%) stddev-sans-first:26.03 05:17:10 INFO - PID 17031 | Values: 143.0 120.0 155.0 181.0 116.0 162.0 148.0 118.0 176.0 121.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.40 05:17:10 INFO - PID 17031 | Values: 162.0 163.0 161.0 162.0 162.0 162.0 163.0 166.0 166.0 168.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:35.86 (48.5%) stddev-sans-first:37.42 05:17:10 INFO - PID 17031 | Values: 73.0 74.0 76.0 165.0 74.0 74.0 75.0 73.0 153.0 75.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:25.35 (32.1%) stddev-sans-first:26.23 05:17:10 INFO - PID 17031 | Values: 79.0 80.0 135.0 79.0 79.0 79.0 134.0 79.0 79.0 125.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:17:10 INFO - PID 17031 | Values: 114.0 114.0 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:2.13 (1.4%) stddev-sans-first:1.33 05:17:10 INFO - PID 17031 | Values: 154.0 148.0 149.0 147.0 151.0 148.0 148.0 147.0 149.0 150.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 05:17:10 INFO - PID 17031 | Values: 94.0 94.0 94.0 98.0 94.0 94.0 95.0 94.0 94.0 93.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 05:17:10 INFO - PID 17031 | Values: 52.0 52.0 51.0 51.0 54.0 52.0 51.0 52.0 52.0 53.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 05:17:10 INFO - PID 17031 | Values: 55.0 55.0 56.0 55.0 55.0 55.0 55.0 56.0 55.0 56.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:2.00 (2.7%) stddev-sans-first:2.07 05:17:10 INFO - PID 17031 | Values: 74.0 76.0 75.0 77.0 75.0 75.0 80.0 74.0 74.0 73.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:13.20 (10.7%) stddev-sans-first:13.99 05:17:10 INFO - PID 17031 | Values: 127.0 116.0 120.0 126.0 117.0 122.0 121.0 123.0 124.0 162.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:178.00 stddev:6.43 (3.6%) stddev-sans-first:6.39 05:17:10 INFO - PID 17031 | Values: 184.0 191.0 181.0 178.0 178.0 173.0 171.0 177.0 172.0 171.0 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.01 05:17:10 INFO - PID 17031 | Values: 66.0 64.0 65.0 65.0 65.0 63.0 64.0 65.0 66.0 63.0 05:17:10 INFO - PID 17031 | -------- Summary: end -------- 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | 05:17:10 INFO - PID 17031 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:17:10 INFO - PID 17031 | 05:17:11 INFO - PID 17031 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:17:11 INFO - TEST-INFO | 17031: exit 0 05:17:11 INFO - TEST-OK | kraken | took 62131ms 05:17:11 INFO - SUITE-END | took 1175s 05:17:11 INFO - Completed test suite (00:19:35) 05:17:11 INFO - javascript benchmark 05:17:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8571.070128100964, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.223037586168, 3314.7348212143024, 3318.3529211803693, 3342.2479942013065, 3349.179451034497, 5982.551308651858, 6198.070289456584, 6258.123862659226, 6268.279147897993, 6320.715567799449, 6118.082287656854, 6145.324014358417, 6164.229471316085, 6168.228971378578, 6184.536159788023, 5665.8583535411535, 5665.8583535411635, 5687.175359572881, 5692.743826527816, 5773.422657734214, 5733.713314334287, 5740.282464691913, 5752.884942301152, 5831.271091113611, 5864.824055278327, 5462.6995515246645, 5691.317041954951, 5728.828135155952, 5778.248827652378, 5845.03556913111, 5582.190582365575, 5688.60179787415, 5768.7980920668, 5769.855753606152, 5774.624649397818, 5665.518430933375, 5764.827055188351, 5766.336871259775, 5779.133130030487, 5783.421657834225, 6195.690215489208, 6208.937910620881, 6209.658468784215, 6225.782097626607, 6299.559030867841, 6422.26143993442, 6543.509236807211, 6545.574537655038, 6548.574342667712, 6732.528722989393, 6624.8012559623285, 6652.467802575782, 6654.334566543307, 6655.201375834882, 6655.90177620692, 6166.753329866845, 6168.321484636686, 6216.658083805389, 6241.469475094668, 6246.750129994794, 6860.6912688929115, 6893.827654308682, 6901.068355771907, 6915.481338899502, 6917.619530925847, 6581.539292249592, 6585.6377899216, 6666.866662666719, 6675.899861502081, 6694.732210711517, 6464.159659244362, 6489.286178520359, 6636.170478690164, 6698.363655452724, 6760.391564759196, 6665.633390163587, 6687.565308255045, 6691.26396096429, 6691.7323307068145, 6709.93290067093, 6663.833404164935, 6715.630640314732, 6759.526833121733, 6760.7633732820095, 6765.526413151032, 5245.711485868237, 5256.132738098171, 5329.973350133225, 5350.5987050971335, 5361.919571206435, 4547.909041819145, 4568.954310456853, 4572.337011133367, 4653.115907977473, 4675.392199014106, 5739.081746920473, 5745.195672605839, 5874.32445268791, 5943.64338139713, 5948.196993405835, 6645.767398141042, 6746.426553742888, 6757.324267573302, 6762.594244345355, 6767.1202743644, 5806.88386232273, 5915.792947246911, 5932.0508718604815, 5933.6736479493175, 5938.8812223755285, 5755.0791873300905, 5757.136429535603, 5843.5325173985975, 5845.357010728816, 5849.093390524476, 6371.394717501737, 6508.153939987771, 6619.3380661933425, 6628.734850606018, 6640.136782218281, 6564.573302735307, 6585.5719378242175, 6589.505787066085, 6599.9010014848855, 6600.9339906602245, 6485.513586481127, 6489.059086432535, 6489.837754056186, 6496.545241833026, 6499.967500162469, 6452.419282264619, 6487.578307410004, 6531.934680653323, 6559.0817285579105, 6561.80314590563, 6754.0881980931945, 6776.45788336922, 6821.942598897179, 6825.931740682729, 6855.006024126574, 6478.870422591616, 6482.254540727877, 6490.643014634241, 6590.80227593173, 6591.736330546724, 6301.905471418024, 6397.744090236339, 6418.261899881387, 6494.6103233806125, 6503.414692677682, 6300.621962682254, 6325.367463253638, 6338.746450141943, 6365.7135428904885, 6374.872502550016, 6339.0, 6444.13004244421, 6458.934275844433, 6488.967555162383, 6549.803505894831, 6064.4541991221, 6234.657093859882, 6248.4064013918605, 6314.305426403183, 6317.747290108528], "value": 6093.122744049119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.5406610100043, 830.2486249943801, 857.7641148684113, 862.8490014247506, 1103.8951299626542, 28682.569761453567, 29233.85383073087, 37965.81017094911, 38806.0, 38834.22331553367, 38661.80669096651, 39074.41388379176, 39085.41371879417, 39116.80441597795, 39192.804035979854, 7457.477976541631, 7670.271324224218, 7671.079470463525, 7676.577788221645, 7677.6161191940455, 7527.736529221478, 7625.923740762604, 7630.732924347649, 7636.121845987699, 7639.656215470317, 7620.885686714703, 7662.655180516862, 7677.884831727529, 7704.845903081963, 7709.884351734729, 7607.885881711779, 7638.809029774245, 7642.159362470124, 7643.159252482223, 7645.808854778619, 7511.399088072941, 7572.507786993828, 7575.318221360104, 7577.090749110087, 7578.8484230315635, 34408.13979650529, 34437.13907152316, 34588.654113459044, 34595.827020864985, 34603.4809477858, 3438.9312213755584, 3475.4786781982652, 3480.1821571930577, 3495.8951231463097, 3503.6496350365014, 28763.0, 28844.134675959755, 28931.56602650941, 29056.273593160127, 29056.854715726287, 4966.503349665005, 5101.0, 5118.309028281172, 5143.434222235588, 5165.199394093921, 185008.0, 187134.0, 187236.0, 187328.0, 187707.0, 43696.0, 43749.78125109354, 43803.0, 43935.34096988484, 44009.339859902124, 45972.54027459749, 46071.539284606726, 46454.535454645695, 46494.0, 46545.0, 13176.143550669176, 13395.0, 14925.10449373041, 15176.468823591122, 15184.468543601142, 11240.887591123985, 11287.435628218556, 11293.096552275798, 11326.263792853439, 11334.829977550344, 13170.275634839983, 13243.0, 13256.53602123921, 13333.866661333457, 13383.866161338263, 5471.0, 5519.365272993577, 5555.583331250173, 5688.0, 5697.857553561194, 964.840801267797, 983.4443539400216, 983.9163671088038, 1004.6182450668845, 1005.7485628592851, 20115.39653810388, 20571.38285851427, 20573.588528229353, 20574.382768516967, 20990.580188396147, 1078.9730256743487, 1079.8596182496226, 1086.364476781092, 1095.4499383372597, 1095.9342439453499, 11105.278156919774, 11113.888861111447, 11255.66233013011, 11452.770944581061, 11571.016463600688, 223831.0, 225971.0, 226100.0, 226487.0, 227085.0, 46985.5301446988, 47009.5299047012, 47352.28971565429, 47356.05287894223, 47416.0, 1347.0, 1429.6640289531952, 1435.4617018618228, 1438.079629037417, 1444.609955312081, 20149.0, 20286.89856550708, 20455.28406505765, 25883.223503294932, 26728.0, 46017.53982460133, 46086.30870537012, 46155.0, 46164.307535386324, 46221.30668040049, 198427.0, 198498.0, 198586.0, 198675.0, 199188.0, 31505.684943150274, 31605.5259171108, 32436.837815811716, 32919.67080329166, 32940.835295823366, 40880.79559602302, 42403.363949540166, 42564.787176063925, 42732.78633606937, 42763.572364277206, 31472.842635786674, 31841.840790795897, 31977.200569985005, 32231.0, 32356.838215809712, 31224.843875780476, 31619.36761264808, 32018.67981320157, 32096.67903320937, 32200.19499512531, 33924.15189620279, 34749.13127171841, 34983.825080874434, 35037.649623503436, 35063.64936350604, 30731.846340768152, 30780.0, 30942.845285773426, 31043.37913241768, 31358.52962205523, 22853.20013799509, 23121.768782311963, 23220.419489512897, 23674.881625591763, 24155.275341739776], "value": 16510.78900577759, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8235823357408, 553.3194171169464, 555.2537270284954, 556.1518684006892, 567.409893710541, 21091.367258982234, 21740.89129554352, 21834.0, 21866.23468178614, 22429.102835886544, 23754.76245237547, 24177.153799617015, 24263.514729705395, 24310.906009229584, 24373.634395484038, 6515.283318834936, 6623.73505059797, 6624.900626490607, 6625.569337993015, 6631.204255489348, 6027.457528822405, 6540.34596540347, 6567.868642627144, 6577.769778057769, 6578.60528368297, 6524.4454221391, 6525.053867189255, 6527.379898909619, 6529.085927970064, 6545.410913017828, 6468.967655161718, 6469.061986012049, 6469.159009328804, 6472.158619379474, 6472.417482426557, 6043.697815109227, 6056.606320589148, 6068.726907289182, 6073.301570319381, 6077.878442431127, 27934.720652793618, 28713.56929646057, 29182.0, 29239.85380073086, 29315.267118322, 1702.285040283084, 1729.2218501674297, 1731.8268173182707, 1733.7139372003605, 1735.210479231959, 19147.425577232567, 19408.4177474676, 19446.51383715404, 19754.802451975585, 20687.0, 2538.708048574419, 2543.224316583441, 2595.286296268522, 2641.141628970592, 2648.046703186851, 140470.29764851212, 144072.0, 146589.0, 147441.26279368642, 147480.26259868633, 19923.0, 20710.896445517676, 20721.58556828855, 21226.726396415954, 22172.223972160897, 41087.7945610276, 41149.38275925864, 41171.58828411737, 41210.587894120676, 41272.0, 11233.55065797359, 11505.597304094317, 11548.884511154782, 11551.422428878523, 11632.185746997799, 7866.606669666494, 8262.586870656563, 9544.42733435996, 9609.183219426288, 9726.805463890683, 10747.78504429907, 10793.78412431747, 11087.279326843729, 11226.719332016764, 11331.376774277329, 3551.893443196708, 3556.76881002734, 3796.6962642989047, 4052.9594704052583, 4110.671146308288, 919.5586118662945, 942.7784470649392, 943.2265542255421, 951.8048799996122, 952.0907533305676, 17979.910100449677, 18187.0, 23657.0, 23721.406964826016, 24733.2580022596, 1018.607835983137, 1023.3808545829665, 1028.665683652816, 1029.0789743179812, 1034.0590063042596, 10706.503268627195, 10887.618933337295, 11024.944875275733, 11084.334939903632, 11107.333559986266, 459925.0, 475027.0, 515348.0, 517579.0, 525447.0, 112480.0, 120305.0, 122814.3859280698, 124443.0, 125326.0, 1181.4447209811374, 1210.2798834693344, 1238.4550797649185, 1243.2354102227066, 1243.6704273367566, 21362.893185533972, 21435.78564214338, 21453.14187432485, 21504.462388440414, 21783.564328713655, 62912.37087629065, 63711.362886370545, 64044.0, 64977.35022649713, 65747.0, 81342.0, 81915.0, 82489.0, 84268.0, 85491.0, 21143.154273828874, 21219.7878021224, 21712.0, 21727.782722172575, 21944.780552194912, 23489.295321140395, 24152.87923560371, 24263.75736242615, 24312.27063188107, 24372.390690232885, 17768.378106766202, 18346.54133646616, 18463.261469541067, 18490.44528664142, 18532.536686582403, 16645.83354166443, 16928.15359232058, 17142.485725428258, 17170.141492925555, 17947.461576152735, 18255.90872045631, 18669.71995420097, 18737.906310468905, 18768.155433005275, 18769.249230031193, 20011.299604513773, 21202.15191392327, 21260.0, 21295.78704212938, 21300.7869921305, 18150.818491814913, 18335.81664183341, 18337.541561461072, 18375.356862509747, 18401.63196736031], "value": 12922.37721777606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.9874701252988, 1321.6497628128548, 1333.5465941579862, 1336.1648969394125, 1340.7318536292737, 14153.15081095135, 14717.558473245806, 15269.618259543517, 15289.770653440208, 15306.0, 14918.552443426715, 15132.924335378335, 15205.23973801311, 15226.847731522681, 15242.237888105577, 2602.297379707478, 2661.813673042888, 2721.047633328339, 2727.8543011934935, 2737.20621019904, 2726.509228338898, 2731.5356389413746, 2781.2490627530556, 2782.3183320086605, 2783.7216278372202, 2642.445086531831, 2688.784897208219, 2712.0, 2713.036871910473, 2714.4435390744948, 2607.58278675411, 2626.986865065672, 2660.175345642838, 2666.080202330193, 2670.3324168957856, 2571.2029270926073, 2609.3607066268696, 2611.4385407137365, 2612.3991481959256, 2647.5234457797587, 14367.0, 14466.493672721404, 14473.565793026226, 14476.0, 14489.058211216237, 7717.768466946, 8034.116247212802, 8041.95979020107, 8043.235892590194, 8052.59737013147, 5265.262863199156, 5490.533304669108, 5586.24585680932, 5606.327240731098, 5623.044082505943, 1869.2896699254331, 1880.2854915132161, 1906.8760530565469, 1934.3133187718297, 1946.3674305850654, 24139.758602413927, 24656.506869862504, 24852.50294994108, 24861.87569062161, 24877.253682389557, 6944.652767361612, 6955.374016338554, 6978.616176110261, 7118.145822501333, 7120.928790712027, 19133.425997220107, 19167.0, 19173.90413047926, 19185.808141918682, 19189.520261993282, 7403.51877127985, 7493.0, 7625.351845093118, 7649.196834332315, 7673.040869891263, 6784.728610855511, 6873.656317184121, 6912.619805910723, 6919.930800692029, 6939.75710850128, 5074.898502030012, 5191.6884986900905, 5214.374275087014, 5242.1088414969545, 5242.501962313574, 1469.8530146985215, 1477.0546850015999, 1477.4016523307862, 1485.6434455730546, 1492.276246020679, 838.2832678060171, 854.2525290370926, 860.6772460327377, 863.749512641327, 874.61079819481, 6869.175698916062, 6902.792916212522, 6936.7225310987, 6970.024196612479, 7007.369336759614, 679.3647939176885, 679.6092246958019, 685.348918527401, 692.5394612582677, 698.7135274537416, 4542.545745425497, 4952.653314268039, 5029.597632189416, 5030.974845125751, 5054.646174767731, 20272.797272027092, 20381.0, 21151.576968460544, 21374.465638359165, 21433.142674292852, 20782.896085519475, 20854.687179692315, 20870.895645521676, 20878.060487278108, 21037.0, 10009.449480278654, 10456.790864182674, 10561.471926403648, 10615.0, 10618.0, 8279.751607451786, 8388.832223355377, 8655.221030107321, 8824.3381746368, 9071.546422678708, 17204.827951720323, 17554.473365799047, 17569.648607028044, 17786.644267114843, 18173.636527269646, 17673.82326176773, 17771.822281777535, 18057.458276251735, 18628.254869805056, 18748.343807966656, 13214.0, 13540.390682419118, 13541.0, 13547.525836595672, 13568.525101621395, 13261.734765304833, 13494.190348579117, 13595.252261125337, 13603.659908502366, 13619.659508512366, 10855.2401331906, 10920.617778378037, 11014.779704406028, 11114.110871130451, 11232.66302010941, 10480.528376222936, 10539.104176145114, 10708.571657133627, 11041.227114101936, 11191.944040279746, 9037.95481022617, 9041.23149532297, 9079.364444489087, 9140.497272649802, 9168.495732734764, 7201.387882030086, 7257.673404696907, 7266.237045110187, 7318.048653674989, 7334.083239595051, 7033.261507541839, 7078.8938165928585, 7219.891701624375, 7221.458390620619, 7275.126984761862], "value": 6491.130949711572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.44231774109267, 508.2554058304584, 514.1721827857149, 518.8261932252695, 527.4330095147717, 6232.314445411007, 6257.124002639634, 6293.0, 6310.936890631092, 6344.637342208631, 5991.281046274442, 6088.969555152218, 6270.27891792444, 6276.717547710353, 6277.950721784447, 5149.17613181891, 5198.376194856613, 5201.479852014806, 5204.579870360281, 5267.130923397634, 5070.315507406508, 5202.791888324463, 5278.498542638443, 5284.0, 5292.259083728281, 5171.896562068757, 5202.297689811884, 5219.71291578963, 5259.658122222062, 5288.101022826128, 5173.974130129344, 5173.974130129344, 5218.817341393071, 5223.921641175385, 5224.895502089975, 4845.927311090337, 4853.174960256765, 4857.465678775332, 4862.683925544864, 4875.829345972874, 6180.48824358221, 6198.3801619838105, 6232.844178895564, 6270.09083682868, 6299.8740025199695, 6031.336552979169, 6075.7873474428625, 6107.358727333655, 6113.663748493831, 6123.357047509992, 6650.567713098633, 6654.401103900624, 6691.330866913269, 6754.662266886636, 6783.116156367408, 5295.523402893758, 5325.920111198335, 5335.839924802262, 5364.946350536484, 5387.572293342268, 7022.578645281299, 7050.0, 7082.5396349237135, 7127.964360178218, 7129.928700712979, 5527.093152862256, 5530.944690553123, 5545.916811247835, 5547.805826796042, 5552.805651802168, 5607.130894711327, 5613.494785469327, 5642.915356269659, 5646.153077038477, 5650.9263239984275, 5996.220491336098, 6083.866808593578, 6116.235470566179, 6129.233845769279, 6139.969300153471, 6711.496637752188, 6718.899216511756, 6753.392194702402, 6758.222804377461, 6784.287649796799, 1844.5019844641872, 1866.5893503429224, 1911.961760764777, 1936.206155476248, 1954.6090781843689, 1433.8207724034496, 1444.732724445981, 1447.7249322628668, 1453.382312517176, 1464.8535146485267, 5857.648541087463, 5892.351841297454, 5894.263217097863, 5907.438793314628, 5922.970385148046, 6626.701798418986, 6813.863722725518, 6826.795196144124, 6846.261495401879, 6883.931160688429, 5894.145348924468, 5904.291485021825, 5937.376575459514, 5958.6424814511265, 5970.253718285215, 3559.982200089035, 3575.4636804479014, 3607.3867442534834, 3622.5471816022996, 3643.143861192618, 6709.161354830646, 6721.428678562279, 6738.561993470409, 6761.425278851254, 6780.93219067803, 6973.686184121727, 6986.336298051677, 6989.720411183597, 7042.964785176041, 7063.505554611128, 6612.537122401386, 6662.766803161866, 6733.0, 6741.157355330583, 6775.288594697486, 6660.368209788633, 6704.564203326768, 6793.724102425545, 6874.346937040973, 6898.965505172442, 6641.535092543476, 6736.360045795642, 6759.797206083826, 6760.0, 6770.086038384755, 6617.37874220819, 6632.015592983081, 6637.1703537057865, 6650.634215118215, 6660.300668429939, 4936.062148191832, 4973.229149481836, 5005.34930459038, 5011.248312753116, 5054.519820617035, 6608.372204640552, 6739.730410783513, 6776.186857577122, 6904.620245886525, 6917.0, 6378.394052564999, 6602.240742314503, 6606.174228221473, 6629.801105966829, 6643.60138391698, 6574.8356291093105, 6593.835154121185, 6600.60396376219, 6611.834704132243, 6628.436582890508, 6383.553151279366, 6528.714949767544, 6555.475561954937, 6556.8360790978695, 6610.8347291318105, 6660.83435398813, 6664.866702665822, 6688.398044176048, 6693.9624358224555, 6696.531242812956, 6413.743450261937, 6417.839554011187, 6448.422608938949, 6476.514261430506, 6499.122618446449], "value": 5248.485927351059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.8481265778487, 884.3500027479803, 897.0401670212875, 898.8157427727313, 902.147470640245, 18589.907050464746, 19367.418977430665, 19559.826410415368, 19677.409677709657, 20987.895060524716, 18779.62440751184, 18799.81200187998, 18862.0, 18866.528336791554, 18887.527811804714, 838.5262326785378, 923.8752768376283, 942.1520631431698, 944.2446043165475, 957.1051067252107, 846.5090247656344, 846.9110743371949, 848.1052489623476, 848.495145388496, 848.7708318753932, 952.8332541805191, 982.2633025231077, 990.2721499697752, 994.1102713071797, 999.6601155607092, 974.488393593362, 981.1709105805619, 981.6367943860818, 981.66623348062, 982.2583949118441, 714.653393104344, 716.8207948012997, 719.0149495191569, 719.2663483247059, 719.3885197582066, 18215.908920455444, 18517.166727497293, 18648.347307844295, 18815.435536933914, 19808.504787380287, 20504.487387815276, 20663.79336206634, 20773.480662983395, 21169.47076323089, 21171.364859054098, 16960.40638577656, 17187.312507499686, 17449.476515704548, 17487.82512174875, 17518.91240543789, 3669.9266014679824, 3679.5952445231005, 3693.778373297584, 3703.4259689748133, 3704.073981504624, 129292.3535382317, 129467.35266323702, 132898.0, 132989.0, 133091.33454332763, 16218.270177842025, 16626.58433539171, 16672.58318542022, 16827.57931051709, 16919.0, 30051.69948300489, 30447.695523044928, 30614.611132767564, 30725.0, 30781.076567703003, 8468.49189048659, 8576.785580360542, 8596.312295016383, 8597.26923211534, 8607.139286071468, 3693.538307711536, 3864.497615310048, 4198.244316023145, 4332.1985432695055, 4358.978205108954, 5026.547610715053, 5162.9741851291255, 5164.741762911839, 5165.14775062118, 5167.276581278624, 1077.4289626497969, 1089.1069323154936, 1100.1748688483638, 1138.1463902073444, 1145.4330106597288, 664.4186336955164, 676.47573130824, 692.7679227458757, 693.9063226464464, 699.1086364884711, 10890.821835632747, 11058.281211721212, 11365.261258018203, 11391.316521008766, 11850.11124165691, 680.0750978669006, 682.0928165539821, 690.3338278561213, 694.2432748304373, 694.6908625661532, 5503.532199763065, 5664.320281566238, 5680.77276908919, 5713.714314284269, 5830.650160990354, 104862.0, 105887.47056264823, 106395.0, 108396.0, 110219.89780102097, 90606.0, 91482.0, 91745.08254917499, 93425.0, 94427.0, 82560.0, 83165.0, 85107.0, 86239.0, 87996.12003880007, 10169.389836609827, 10319.019693129141, 10369.429681367597, 10401.375917444977, 10663.94668026686, 39148.80425597854, 40535.797321013204, 41290.0, 41964.580354197285, 41965.370519441625, 70514.64742676253, 73498.0, 73622.26377736368, 73790.0, 75461.24538754762, 17824.732629010316, 18759.34342298013, 18847.434576962714, 18883.433496995112, 19411.126499307284, 18500.612454066268, 18752.437426877215, 20239.59520809546, 20252.696209556572, 20493.0, 16219.756703649691, 16319.0, 16473.423430179886, 16656.666866662355, 17230.655386892442, 17076.829231707525, 19554.902225488782, 19989.800101998793, 20023.399298021082, 20105.19579216815, 17214.913925430294, 17500.474985750447, 17571.824281757017, 17820.10899455048, 17896.821031790038, 12349.506019759468, 12572.685682858002, 12883.80674289905, 13167.2757998311, 13367.131136476099, 14326.785098223327, 14360.784588231394, 14518.564443066725, 14530.273486325852, 14575.781363279348], "value": 8951.181865048822, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 99.0, 106.0, 106.0, 112.0, 108.0, 99.0, 108.0, 108.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 155.0, 181.0, 116.0, 162.0, 148.0, 118.0, 176.0, 121.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 162.0, 162.0, 163.0, 166.0, 166.0, 168.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 165.0, 74.0, 74.0, 75.0, 73.0, 153.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 135.0, 79.0, 79.0, 79.0, 134.0, 79.0, 79.0, 125.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 148.0, 149.0, 147.0, 151.0, 148.0, 148.0, 147.0, 149.0, 150.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 98.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 54.0, 52.0, 51.0, 52.0, 52.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 77.0, 75.0, 75.0, 80.0, 74.0, 74.0, 73.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 120.0, 126.0, 117.0, 122.0, 121.0, 123.0, 124.0, 162.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 191.0, 181.0, 178.0, 178.0, 173.0, 171.0, 177.0, 172.0, 171.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 65.0, 65.0, 63.0, 64.0, 65.0, 66.0, 63.0], "value": 64.6, "unit": "score"}]}]} 05:17:11 INFO - Return code: 0 05:17:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:11 INFO - # TBPL SUCCESS # 05:17:11 INFO - Running post-action listener: _package_coverage_data 05:17:11 INFO - Running post-action listener: _resource_record_post_action 05:17:11 INFO - [mozharness: 2017-08-25 12:17:11.845664Z] Finished run-tests step (success) 05:17:11 INFO - Running post-run listener: _resource_record_post_run 05:17:11 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 427593728; Read time: 12; Write time: 574660 05:17:11 INFO - TinderboxPrint: CPU usage
13.1% 05:17:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:17:11 INFO - TinderboxPrint: I/O write bytes / time
427,593,728 / 574,660 05:17:11 INFO - TinderboxPrint: CPU idle
8,259.5 (86.8%) 05:17:11 INFO - TinderboxPrint: CPU user
1,196.7 (12.6%) 05:17:11 INFO - TinderboxPrint: Swap in / out
0 / 0 05:17:11 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 105168896; Read time: 0; Write time: 206144 05:17:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:17:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322424832; Read time: 12; Write time: 368516 05:17:12 INFO - Running post-run listener: _upload_blobber_files 05:17:12 INFO - Blob upload gear active. 05:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:12 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 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:17 INFO - (blobuploader) - INFO - Done attempting. 05:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:18 INFO - (blobuploader) - INFO - Done attempting. 05:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:19 INFO - (blobuploader) - INFO - Done attempting. 05:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:20 INFO - (blobuploader) - INFO - Done attempting. 05:17:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:20 INFO - Return code: 0 05:17:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fa109c4c2a16759657139264f95057c2efae7ba27a0bdbcfd0ad460830e566073137b99fb839ba7e478fc62ab0b9d13c29d4ca6918dc7a8ac3a2d779d84f8f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f8ccf3837d64c8b25c359a8863eb34f4dfb6f2cab05f49f47deb299bc7d45f63238fff466ba72e29a07428f30b27e1a722c12451c820b64e4191376691649c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6efabf563f483a83a061c1c43a95f8e42ef762d9f172e0986f0a0ed5fce7f4088d71cb376a9b4c9a797f5f18eaea23a99bdb0e4666745a399ac27d552517d737"} 05:17:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:20 INFO - Contents: 05:17:20 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fa109c4c2a16759657139264f95057c2efae7ba27a0bdbcfd0ad460830e566073137b99fb839ba7e478fc62ab0b9d13c29d4ca6918dc7a8ac3a2d779d84f8f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f8ccf3837d64c8b25c359a8863eb34f4dfb6f2cab05f49f47deb299bc7d45f63238fff466ba72e29a07428f30b27e1a722c12451c820b64e4191376691649c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6efabf563f483a83a061c1c43a95f8e42ef762d9f172e0986f0a0ed5fce7f4088d71cb376a9b4c9a797f5f18eaea23a99bdb0e4666745a399ac27d552517d737"} 05:17:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:20 INFO - Copying logs to upload dir... 05:17:20 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.730936 ========= master_lag: 1.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-25 05:17:21.775306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:21.779522) ========= 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=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fa109c4c2a16759657139264f95057c2efae7ba27a0bdbcfd0ad460830e566073137b99fb839ba7e478fc62ab0b9d13c29d4ca6918dc7a8ac3a2d779d84f8f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f8ccf3837d64c8b25c359a8863eb34f4dfb6f2cab05f49f47deb299bc7d45f63238fff466ba72e29a07428f30b27e1a722c12451c820b64e4191376691649c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6efabf563f483a83a061c1c43a95f8e42ef762d9f172e0986f0a0ed5fce7f4088d71cb376a9b4c9a797f5f18eaea23a99bdb0e4666745a399ac27d552517d737"} build_url:https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fa109c4c2a16759657139264f95057c2efae7ba27a0bdbcfd0ad460830e566073137b99fb839ba7e478fc62ab0b9d13c29d4ca6918dc7a8ac3a2d779d84f8f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2f8ccf3837d64c8b25c359a8863eb34f4dfb6f2cab05f49f47deb299bc7d45f63238fff466ba72e29a07428f30b27e1a722c12451c820b64e4191376691649c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6efabf563f483a83a061c1c43a95f8e42ef762d9f172e0986f0a0ed5fce7f4088d71cb376a9b4c9a797f5f18eaea23a99bdb0e4666745a399ac27d552517d737"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:21.814896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:21.817212) ========= 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=af724c981e2a0f424dbabf99000001e7-1503642063.414438-246993087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:21.866937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 05:17:21.867274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 05:17:21.867555) ========= ========= Total master_lag: 1.69 =========