builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1503252004.18 results: success (0) revision: cab35526779367774b3ecea2f7a8a5c0993caa77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.178750) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.179152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.179434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.195739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.196044) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 11:00:05-- 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% 225M=0s 2017-08-20 11:00:05 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.368198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.372756) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024073 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:04.460913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-20 11:00:04.461246) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cab35526779367774b3ecea2f7a8a5c0993caa77 --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 cab35526779367774b3ecea2f7a8a5c0993caa77 --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=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 11:00:05,757 truncating revision to first 12 chars 2017-08-20 11:00:05,757 Setting DEBUG logging. 2017-08-20 11:00:05,757 attempt 1/10 2017-08-20 11:00:05,757 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cab355267793?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 11:00:06,513 unpacking tar archive at: mozilla-central-cab355267793/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086535 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-20 11:00:05.574018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:05.574315) ========= script_repo_revision: cab35526779367774b3ecea2f7a8a5c0993caa77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:05.574685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:05.574951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 11:00:05.819538) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-08-20 11:00:05.819850) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:07 INFO - MultiFileLogger online at 20170820 11:00:07 in /builds/slave/test 11:00:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:00:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:07 INFO - {'append_to_log': False, 11:00:07 INFO - 'base_work_dir': '/builds/slave/test', 11:00:07 INFO - 'blob_upload_branch': 'Firefox', 11:00:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:07 INFO - 'branch': 'Firefox', 11:00:07 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:07 INFO - 'code_coverage': False, 11:00:07 INFO - 'config_files': ('talos/linux_config.py',), 11:00:07 INFO - 'default_actions': ('clobber', 11:00:07 INFO - 'read-buildbot-config', 11:00:07 INFO - 'download-and-extract', 11:00:07 INFO - 'populate-webroot', 11:00:07 INFO - 'create-virtualenv', 11:00:07 INFO - 'install', 11:00:07 INFO - 'setup-mitmproxy', 11:00:07 INFO - 'run-tests'), 11:00:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:07 INFO - 'disable_ccov_upload': False, 11:00:07 INFO - 'download_minidump_stackwalk': True, 11:00:07 INFO - 'download_symbols': 'ondemand', 11:00:07 INFO - 'enable_stylo': False, 11:00:07 INFO - 'enable_webrender': False, 11:00:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:07 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:07 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:07 INFO - 'gecko_profile': False, 11:00:07 INFO - 'gecko_profile_interval': 0, 11:00:07 INFO - 'installer_path': 'installer.exe', 11:00:07 INFO - 'log_level': 'info', 11:00:07 INFO - 'log_name': 'talos', 11:00:07 INFO - 'log_to_console': True, 11:00:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:07 INFO - 'opt_config_files': (), 11:00:07 INFO - 'pip_index': False, 11:00:07 INFO - 'suite': 'dromaeojs-e10s', 11:00:07 INFO - 'system_bits': '32', 11:00:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:07 INFO - 'title': 'talos-linux64-ix-074', 11:00:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:07 INFO - 'use_talos_json': True, 11:00:07 INFO - 'verify': 'False', 11:00:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:07 INFO - 'work_dir': 'build'} 11:00:07 INFO - [mozharness: 2017-08-20 18:00:07.279613Z] Running clobber step. 11:00:07 INFO - Running pre-action listener: _resource_record_pre_action 11:00:07 INFO - Running main action method: clobber 11:00:07 INFO - rmtree: /builds/slave/test/build 11:00:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:08 INFO - Running post-action listener: _resource_record_post_action 11:00:08 INFO - [mozharness: 2017-08-20 18:00:08.810682Z] Finished clobber step (success) 11:00:08 INFO - [mozharness: 2017-08-20 18:00:08.810781Z] Running read-buildbot-config step. 11:00:08 INFO - Running pre-action listener: _resource_record_pre_action 11:00:08 INFO - Running main action method: read_buildbot_config 11:00:08 INFO - Using buildbot properties: 11:00:08 INFO - { 11:00:08 INFO - "project": "", 11:00:08 INFO - "product": "firefox", 11:00:08 INFO - "who": "ffxbld@noreply.mozilla.org", 11:00:08 INFO - "installer_path": "public/build/target.tar.bz2", 11:00:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:00:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:00:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:00:08 INFO - "stage_platform": "linux64-stylosequential", 11:00:08 INFO - "basedir": "/builds/slave/test", 11:00:08 INFO - "buildnumber": 41, 11:00:08 INFO - "platform": "ubuntu64_hw_styloseq", 11:00:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:00:08 INFO - "slavebuilddir": "test", 11:00:08 INFO - "taskId": "TfMc898bTbKlCoflzHciow", 11:00:08 INFO - "branch": "mozilla-central", 11:00:08 INFO - "script_repo_revision": "production", 11:00:08 INFO - "revision": "cab35526779367774b3ecea2f7a8a5c0993caa77", 11:00:08 INFO - "slavename": "talos-linux64-ix-074", 11:00:08 INFO - "repo_path": "mozilla-central" 11:00:08 INFO - } 11:00:08 INFO - Finding installer, test and symbols from parent task. 11:00:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfMc898bTbKlCoflzHciow'}, attempt #1 11:00:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfMc898bTbKlCoflzHciow'}, attempt #1 11:00:09 INFO - Task dependencies: LJxQRdN-QvOV7_FMIYAiQw 11:00:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw'}, attempt #1 11:00:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 11:00:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.test_packages.json 11:00:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.crashreporter-symbols.zip 11:00:10 INFO - Running post-action listener: _resource_record_post_action 11:00:10 INFO - [mozharness: 2017-08-20 18:00:10.176639Z] Finished read-buildbot-config step (success) 11:00:10 INFO - [mozharness: 2017-08-20 18:00:10.176856Z] Running download-and-extract step. 11:00:10 INFO - Running pre-action listener: _resource_record_pre_action 11:00:10 INFO - Running main action method: download_and_extract 11:00:10 INFO - mkdir: /builds/slave/test/build/tests 11:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:10 INFO - trying https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.test_packages.json 11:00:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:00:14 INFO - Downloaded 989 bytes. 11:00:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:00:14 INFO - Using the following test package requirements: 11:00:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:00:14 INFO - u'common': [u'target.common.tests.zip'], 11:00:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:00:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:00:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:00:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:00:14 INFO - u'mozbase': [u'target.common.tests.zip'], 11:00:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:00:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:00:14 INFO - u'web-platform': [u'target.common.tests.zip', 11:00:14 INFO - u'target.web-platform.tests.tar.gz'], 11:00:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:00:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:00:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip 11:00:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:00:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip into memory 11:00:17 INFO - Content-Length response header: 54005753 11:00:17 INFO - Bytes received: 54005753 11:00:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:00:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip 11:00:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:00:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.common.tests.zip into memory 11:00:31 INFO - Content-Length response header: 54005753 11:00:31 INFO - Bytes received: 54005753 11:00:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.talos.tests.zip 11:00:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:00:43 INFO - Fetch https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.talos.tests.zip into memory 11:00:44 INFO - Content-Length response header: 14496256 11:00:44 INFO - Bytes received: 14496256 11:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:44 INFO - trying https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 11:00:44 INFO - Downloading https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:00:48 INFO - Downloaded 62146911 bytes. 11:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 11:00:48 INFO - mkdir: /builds/slave/test/properties 11:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:48 INFO - Contents: 11:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 11:00:48 INFO - Running post-action listener: _resource_record_post_action 11:00:48 INFO - Running post-action listener: find_tests_for_verification 11:00:48 INFO - Running post-action listener: set_extra_try_arguments 11:00:48 INFO - [mozharness: 2017-08-20 18:00:48.476705Z] Finished download-and-extract step (success) 11:00:48 INFO - [mozharness: 2017-08-20 18:00:48.476933Z] Running populate-webroot step. 11:00:48 INFO - Running pre-action listener: _resource_record_pre_action 11:00:48 INFO - Running main action method: populate_webroot 11:00:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:00:48 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:00:48 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:48 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'tests': ['damp', 'tps']}, 11:00:48 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['damp', 'tps']}, 11:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:00:48 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:00:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:00:48 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:00:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:00:48 INFO - 'ts_paint', 11:00:48 INFO - 'tpaint', 11:00:48 INFO - 'sessionrestore', 11:00:48 INFO - 'sessionrestore_many_windows', 11:00:48 INFO - 'sessionrestore_no_auto_restore', 11:00:48 INFO - 'tabpaint']}, 11:00:48 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['a11yr', 11:00:48 INFO - 'ts_paint', 11:00:48 INFO - 'tpaint', 11:00:48 INFO - 'sessionrestore', 11:00:48 INFO - 'sessionrestore_many_windows', 11:00:48 INFO - 'sessionrestore_no_auto_restore', 11:00:48 INFO - 'tabpaint']}, 11:00:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:00:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:00:48 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['bloom_basic_singleton']}, 11:00:48 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['bloom_basic']}, 11:00:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:00:48 INFO - 'tsvgr_opacity', 11:00:48 INFO - 'tart', 11:00:48 INFO - 'tscrollx', 11:00:48 INFO - 'tsvg_static']}, 11:00:48 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['tsvgx', 11:00:48 INFO - 'tsvgr_opacity', 11:00:48 INFO - 'tart', 11:00:48 INFO - 'tscrollx', 11:00:48 INFO - 'tsvg_static']}, 11:00:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:00:48 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--stylo'], 11:00:48 INFO - 'tests': ['tp5o']}, 11:00:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:00:48 INFO - 'talos_options': ['--mitmproxy', 11:00:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:00:48 INFO - '--firstNonBlankPaint'], 11:00:48 INFO - 'tests': ['tp6_google', 11:00:48 INFO - 'tp6_youtube', 11:00:48 INFO - 'tp6_amazon', 11:00:48 INFO - 'tp6_facebook']}, 11:00:48 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:00:48 INFO - 'talos_options': ['--stylo', 11:00:48 INFO - '--mitmproxy', 11:00:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:00:48 INFO - '--firstNonBlankPaint'], 11:00:48 INFO - 'tests': ['tp6_google', 11:00:48 INFO - 'tp6_youtube', 11:00:48 INFO - 'tp6_amazon', 11:00:48 INFO - 'tp6_facebook']}, 11:00:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:00:48 INFO - 'talos_options': ['--stylo', 11:00:48 INFO - '--stylo-threads=1', 11:00:48 INFO - '--mitmproxy', 11:00:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:00:48 INFO - '--firstNonBlankPaint'], 11:00:48 INFO - 'tests': ['tp6_google', 11:00:48 INFO - 'tp6_youtube', 11:00:48 INFO - 'tp6_amazon', 11:00:48 INFO - 'tp6_facebook']}, 11:00:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--xperf_path', 11:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:48 INFO - 'tests': ['tp5n']}, 11:00:48 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:00:48 INFO - 'talos_options': ['--stylo', 11:00:48 INFO - '--xperf_path', 11:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:48 INFO - 'tests': ['tp5n']}}} 11:00:48 INFO - Running post-action listener: _resource_record_post_action 11:00:48 INFO - [mozharness: 2017-08-20 18:00:48.499157Z] Finished populate-webroot step (success) 11:00:48 INFO - [mozharness: 2017-08-20 18:00:48.499247Z] Running create-virtualenv step. 11:00:48 INFO - Running pre-action listener: _resource_record_pre_action 11:00:48 INFO - Running main action method: create_virtualenv 11:00:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:48 INFO - Using real prefix '/usr' 11:00:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:51 INFO - Installing pip.................done. 11:00:51 INFO - Return code: 0 11:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:00:51 INFO - Reading from file tmpfile_stdout 11:00:51 INFO - Output received: 11:00:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:00:51 INFO - Using env: {'DISPLAY': ':0', 11:00:51 INFO - 'HOME': '/home/cltbld', 11:00:51 INFO - 'LANG': 'en_US.UTF-8', 11:00:51 INFO - 'LANGUAGE': 'en_US:en', 11:00:51 INFO - 'LOGNAME': 'cltbld', 11:00:51 INFO - 'MAIL': '/var/mail/cltbld', 11:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:51 INFO - 'MOZ_NO_REMOTE': '1', 11:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:51 INFO - 'NO_EM_RESTART': '1', 11:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:51 INFO - 'PWD': '/builds/slave/test', 11:00:51 INFO - 'SHELL': '/bin/bash', 11:00:51 INFO - 'SHLVL': '1', 11:00:51 INFO - 'TERM': 'linux', 11:00:51 INFO - 'TMOUT': '86400', 11:00:51 INFO - 'USER': 'cltbld', 11:00:51 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:51 INFO - '_': '/tools/buildbot/bin/python'} 11:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:00:51 INFO - Cleaning up... 11:00:51 INFO - Return code: 0 11:00:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:00:51 INFO - Using env: {'DISPLAY': ':0', 11:00:51 INFO - 'HOME': '/home/cltbld', 11:00:51 INFO - 'LANG': 'en_US.UTF-8', 11:00:51 INFO - 'LANGUAGE': 'en_US:en', 11:00:51 INFO - 'LOGNAME': 'cltbld', 11:00:51 INFO - 'MAIL': '/var/mail/cltbld', 11:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:51 INFO - 'MOZ_NO_REMOTE': '1', 11:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:51 INFO - 'NO_EM_RESTART': '1', 11:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:51 INFO - 'PWD': '/builds/slave/test', 11:00:51 INFO - 'SHELL': '/bin/bash', 11:00:51 INFO - 'SHLVL': '1', 11:00:51 INFO - 'TERM': 'linux', 11:00:51 INFO - 'TMOUT': '86400', 11:00:51 INFO - 'USER': 'cltbld', 11:00:51 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:51 INFO - '_': '/tools/buildbot/bin/python'} 11:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:51 INFO - Downloading/unpacking psutil>=3.1.1 11:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:52 INFO - Installing collected packages: psutil 11:00:52 INFO - Running setup.py install for psutil 11:00:53 INFO - building 'psutil._psutil_linux' extension 11:00:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:00:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:00:53 INFO - building 'psutil._psutil_posix' extension 11:00:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:00:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:53 INFO - Successfully installed psutil 11:00:53 INFO - Cleaning up... 11:00:53 INFO - Return code: 0 11:00:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:53 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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:00:53 INFO - Using env: {'DISPLAY': ':0', 11:00:53 INFO - 'HOME': '/home/cltbld', 11:00:53 INFO - 'LANG': 'en_US.UTF-8', 11:00:53 INFO - 'LANGUAGE': 'en_US:en', 11:00:53 INFO - 'LOGNAME': 'cltbld', 11:00:53 INFO - 'MAIL': '/var/mail/cltbld', 11:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:53 INFO - 'MOZ_NO_REMOTE': '1', 11:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:53 INFO - 'NO_EM_RESTART': '1', 11:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:53 INFO - 'PWD': '/builds/slave/test', 11:00:53 INFO - 'SHELL': '/bin/bash', 11:00:53 INFO - 'SHLVL': '1', 11:00:53 INFO - 'TERM': 'linux', 11:00:53 INFO - 'TMOUT': '86400', 11:00:53 INFO - 'USER': 'cltbld', 11:00:53 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:53 INFO - '_': '/tools/buildbot/bin/python'} 11:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:00:54 INFO - Installing collected packages: mozsystemmonitor 11:00:54 INFO - Running setup.py install for mozsystemmonitor 11:00:54 INFO - Successfully installed mozsystemmonitor 11:00:54 INFO - Cleaning up... 11:00:54 INFO - Return code: 0 11:00:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:00:54 INFO - Using env: {'DISPLAY': ':0', 11:00:54 INFO - 'HOME': '/home/cltbld', 11:00:54 INFO - 'LANG': 'en_US.UTF-8', 11:00:54 INFO - 'LANGUAGE': 'en_US:en', 11:00:54 INFO - 'LOGNAME': 'cltbld', 11:00:54 INFO - 'MAIL': '/var/mail/cltbld', 11:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:54 INFO - 'MOZ_NO_REMOTE': '1', 11:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:54 INFO - 'NO_EM_RESTART': '1', 11:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:54 INFO - 'PWD': '/builds/slave/test', 11:00:54 INFO - 'SHELL': '/bin/bash', 11:00:54 INFO - 'SHLVL': '1', 11:00:54 INFO - 'TERM': 'linux', 11:00:54 INFO - 'TMOUT': '86400', 11:00:54 INFO - 'USER': 'cltbld', 11:00:54 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:54 INFO - '_': '/tools/buildbot/bin/python'} 11:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:56 INFO - warning: no files found matching '*.txt' 11:00:56 INFO - no previously-included directories found matching 'build' 11:00:56 INFO - no previously-included directories found matching 'dist' 11:00:56 INFO - no previously-included directories found matching '.git*' 11:00:56 INFO - Installing collected packages: jsonschema, functools32 11:00:56 INFO - Running setup.py install for functools32 11:00:56 INFO - warning: no files found matching '*.txt' 11:00:56 INFO - no previously-included directories found matching 'build' 11:00:56 INFO - no previously-included directories found matching 'dist' 11:00:56 INFO - no previously-included directories found matching '.git*' 11:00:56 INFO - Successfully installed jsonschema functools32 11:00:56 INFO - Cleaning up... 11:00:56 INFO - Return code: 0 11:00:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00: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')]} 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:00:56 INFO - Using env: {'DISPLAY': ':0', 11:00:56 INFO - 'HOME': '/home/cltbld', 11:00:56 INFO - 'LANG': 'en_US.UTF-8', 11:00:56 INFO - 'LANGUAGE': 'en_US:en', 11:00:56 INFO - 'LOGNAME': 'cltbld', 11:00:56 INFO - 'MAIL': '/var/mail/cltbld', 11:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:56 INFO - 'MOZ_NO_REMOTE': '1', 11:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:56 INFO - 'NO_EM_RESTART': '1', 11:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:56 INFO - 'PWD': '/builds/slave/test', 11:00:56 INFO - 'SHELL': '/bin/bash', 11:00:56 INFO - 'SHLVL': '1', 11:00:56 INFO - 'TERM': 'linux', 11:00:56 INFO - 'TMOUT': '86400', 11:00:56 INFO - 'USER': 'cltbld', 11:00:56 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:56 INFO - '_': '/tools/buildbot/bin/python'} 11:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:00:56 INFO - Cleaning up... 11:00:56 INFO - Return code: 0 11:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00: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')]} 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:00:56 INFO - Using env: {'DISPLAY': ':0', 11:00:56 INFO - 'HOME': '/home/cltbld', 11:00:56 INFO - 'LANG': 'en_US.UTF-8', 11:00:56 INFO - 'LANGUAGE': 'en_US:en', 11:00:56 INFO - 'LOGNAME': 'cltbld', 11:00:56 INFO - 'MAIL': '/var/mail/cltbld', 11:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:56 INFO - 'MOZ_NO_REMOTE': '1', 11:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:56 INFO - 'NO_EM_RESTART': '1', 11:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:56 INFO - 'PWD': '/builds/slave/test', 11:00:56 INFO - 'SHELL': '/bin/bash', 11:00:56 INFO - 'SHLVL': '1', 11:00:56 INFO - 'TERM': 'linux', 11:00:56 INFO - 'TMOUT': '86400', 11:00:56 INFO - 'USER': 'cltbld', 11:00:56 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:56 INFO - '_': '/tools/buildbot/bin/python'} 11:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading docopt-0.6.1.tar.gz 11:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:58 INFO - Running setup.py install for blobuploader 11:00:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:00:58 INFO - Running setup.py install for requests 11:00:59 INFO - Running setup.py install for docopt 11:00:59 INFO - Successfully installed blobuploader requests docopt 11:00:59 INFO - Cleaning up... 11:00:59 INFO - Return code: 0 11:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:59 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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:59 INFO - Using env: {'DISPLAY': ':0', 11:00:59 INFO - 'HOME': '/home/cltbld', 11:00:59 INFO - 'LANG': 'en_US.UTF-8', 11:00:59 INFO - 'LANGUAGE': 'en_US:en', 11:00:59 INFO - 'LOGNAME': 'cltbld', 11:00:59 INFO - 'MAIL': '/var/mail/cltbld', 11:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:59 INFO - 'MOZ_NO_REMOTE': '1', 11:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:59 INFO - 'NO_EM_RESTART': '1', 11:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:59 INFO - 'PWD': '/builds/slave/test', 11:00:59 INFO - 'SHELL': '/bin/bash', 11:00:59 INFO - 'SHLVL': '1', 11:00:59 INFO - 'TERM': 'linux', 11:00:59 INFO - 'TMOUT': '86400', 11:00:59 INFO - 'USER': 'cltbld', 11:00:59 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:59 INFO - '_': '/tools/buildbot/bin/python'} 11:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:59 INFO - Running setup.py (path:/tmp/pip-udRe6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:59 INFO - Running setup.py (path:/tmp/pip-X42cRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:59 INFO - Running setup.py (path:/tmp/pip-C4pKhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:59 INFO - Running setup.py (path:/tmp/pip-UzDC1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:59 INFO - Running setup.py (path:/tmp/pip-fNLQ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:59 INFO - Running setup.py (path:/tmp/pip-LNZQwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:00 INFO - Running setup.py (path:/tmp/pip-iJYg4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:00 INFO - Running setup.py (path:/tmp/pip-D2q1AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:00 INFO - Running setup.py (path:/tmp/pip-6aFhjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:00 INFO - Running setup.py (path:/tmp/pip-RzzhOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:00 INFO - Running setup.py (path:/tmp/pip-MArWS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:00 INFO - Running setup.py (path:/tmp/pip-VXSSaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:00 INFO - Running setup.py (path:/tmp/pip-7eczmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:00 INFO - Running setup.py (path:/tmp/pip-_Bxyr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:00 INFO - Running setup.py (path:/tmp/pip-5sskDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:00 INFO - Running setup.py (path:/tmp/pip-pJ74zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:00 INFO - Running setup.py (path:/tmp/pip-K5SvFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:00 INFO - Running setup.py install for manifestparser 11:01:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:01:00 INFO - Running setup.py install for mozcrash 11:01:01 INFO - Running setup.py install for mozdebug 11:01:01 INFO - Running setup.py install for mozdevice 11:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for mozfile 11:01:01 INFO - Running setup.py install for mozhttpd 11:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for mozinfo 11:01:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for mozInstall 11:01:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for mozleak 11:01:01 INFO - Running setup.py install for mozlog 11:01:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for moznetwork 11:01:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:01:01 INFO - Running setup.py install for mozprocess 11:01:02 INFO - Running setup.py install for mozprofile 11:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:01:02 INFO - Running setup.py install for mozrunner 11:01:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:01:02 INFO - Running setup.py install for mozscreenshot 11:01:02 INFO - Running setup.py install for moztest 11:01:02 INFO - Running setup.py install for mozversion 11:01:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:02 INFO - Cleaning up... 11:01:02 INFO - Return code: 0 11:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:02 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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:02 INFO - Using env: {'DISPLAY': ':0', 11:01:02 INFO - 'HOME': '/home/cltbld', 11:01:02 INFO - 'LANG': 'en_US.UTF-8', 11:01:02 INFO - 'LANGUAGE': 'en_US:en', 11:01:02 INFO - 'LOGNAME': 'cltbld', 11:01:02 INFO - 'MAIL': '/var/mail/cltbld', 11:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:02 INFO - 'MOZ_NO_REMOTE': '1', 11:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:02 INFO - 'NO_EM_RESTART': '1', 11:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:02 INFO - 'PWD': '/builds/slave/test', 11:01:02 INFO - 'SHELL': '/bin/bash', 11:01:02 INFO - 'SHLVL': '1', 11:01:02 INFO - 'TERM': 'linux', 11:01:02 INFO - 'TMOUT': '86400', 11:01:02 INFO - 'USER': 'cltbld', 11:01:02 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:02 INFO - '_': '/tools/buildbot/bin/python'} 11:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:02 INFO - Running setup.py (path:/tmp/pip-CVUdrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:03 INFO - Running setup.py (path:/tmp/pip-eAZlnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:03 INFO - Running setup.py (path:/tmp/pip-WtigCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:03 INFO - Running setup.py (path:/tmp/pip-VdF8vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:03 INFO - Running setup.py (path:/tmp/pip-VVw5RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:03 INFO - Running setup.py (path:/tmp/pip-rvMNp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:03 INFO - Running setup.py (path:/tmp/pip-kwSAKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:03 INFO - Running setup.py (path:/tmp/pip-VJTeKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:03 INFO - Running setup.py (path:/tmp/pip-xyo892-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:03 INFO - Running setup.py (path:/tmp/pip-tRoS6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:03 INFO - Running setup.py (path:/tmp/pip-SrbzfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:03 INFO - Running setup.py (path:/tmp/pip-k8JoO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:03 INFO - Running setup.py (path:/tmp/pip-PtKc88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:03 INFO - Running setup.py (path:/tmp/pip-IfpSDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:03 INFO - Running setup.py (path:/tmp/pip-PbXQCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:04 INFO - Running setup.py (path:/tmp/pip-ncpgLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:04 INFO - Running setup.py (path:/tmp/pip-73Zql6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:06 INFO - Downloading blessings-1.6.tar.gz 11:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:06 INFO - Installing collected packages: blessings 11:01:06 INFO - Running setup.py install for blessings 11:01:06 INFO - Successfully installed blessings 11:01:06 INFO - Cleaning up... 11:01:06 INFO - Return code: 0 11:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:06 INFO - Reading from file tmpfile_stdout 11:01:06 INFO - Current package versions: 11:01:06 INFO - argparse == 1.2.1 11:01:06 INFO - blessings == 1.6 11:01:06 INFO - blobuploader == 1.2.4 11:01:06 INFO - docopt == 0.6.1 11:01:06 INFO - functools32 == 3.2.3-2 11:01:06 INFO - jsonschema == 2.5.1 11:01:06 INFO - manifestparser == 1.1 11:01:06 INFO - mozInstall == 1.13 11:01:06 INFO - mozcrash == 1.0 11:01:06 INFO - mozdebug == 0.1 11:01:06 INFO - mozdevice == 0.51 11:01:06 INFO - mozfile == 1.2 11:01:06 INFO - mozhttpd == 0.7 11:01:06 INFO - mozinfo == 0.10 11:01:06 INFO - mozleak == 0.1 11:01:06 INFO - mozlog == 3.5 11:01:06 INFO - moznetwork == 0.27 11:01:06 INFO - mozprocess == 0.25 11:01:06 INFO - mozprofile == 0.28 11:01:06 INFO - mozrunner == 6.13 11:01:06 INFO - mozscreenshot == 0.1 11:01:06 INFO - mozsystemmonitor == 0.3 11:01:06 INFO - moztest == 0.8 11:01:06 INFO - mozversion == 1.4 11:01:06 INFO - psutil == 3.1.1 11:01:06 INFO - requests == 1.2.3 11:01:06 INFO - wsgiref == 0.1.2 11:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01: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')]} 11:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01: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')]} 11:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:06 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 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:06 INFO - Using env: {'DISPLAY': ':0', 11:01:06 INFO - 'HOME': '/home/cltbld', 11:01:06 INFO - 'LANG': 'en_US.UTF-8', 11:01:06 INFO - 'LANGUAGE': 'en_US:en', 11:01:06 INFO - 'LOGNAME': 'cltbld', 11:01:06 INFO - 'MAIL': '/var/mail/cltbld', 11:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:06 INFO - 'MOZ_NO_REMOTE': '1', 11:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:06 INFO - 'NO_EM_RESTART': '1', 11:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:06 INFO - 'PWD': '/builds/slave/test', 11:01:06 INFO - 'SHELL': '/bin/bash', 11:01:06 INFO - 'SHLVL': '1', 11:01:06 INFO - 'TERM': 'linux', 11:01:06 INFO - 'TMOUT': '86400', 11:01:06 INFO - 'USER': 'cltbld', 11:01:06 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:06 INFO - '_': '/tools/buildbot/bin/python'} 11:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:01:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:01: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 11:01: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 11:01: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 11:01: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 11:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:01:08 INFO - Installing collected packages: simplejson 11:01:08 INFO - Running setup.py install for simplejson 11:01:08 INFO - building 'simplejson._speedups' extension 11:01:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:01:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:01:09 INFO - Successfully installed simplejson 11:01:09 INFO - Cleaning up... 11:01:09 INFO - Return code: 0 11:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:01: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')]} 11:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01: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')]} 11:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:01:09 INFO - Using env: {'DISPLAY': ':0', 11:01:09 INFO - 'HOME': '/home/cltbld', 11:01:09 INFO - 'LANG': 'en_US.UTF-8', 11:01:09 INFO - 'LANGUAGE': 'en_US:en', 11:01:09 INFO - 'LOGNAME': 'cltbld', 11:01:09 INFO - 'MAIL': '/var/mail/cltbld', 11:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:09 INFO - 'MOZ_NO_REMOTE': '1', 11:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:09 INFO - 'NO_EM_RESTART': '1', 11:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:09 INFO - 'PWD': '/builds/slave/test', 11:01:09 INFO - 'SHELL': '/bin/bash', 11:01:09 INFO - 'SHLVL': '1', 11:01:09 INFO - 'TERM': 'linux', 11:01:09 INFO - 'TMOUT': '86400', 11:01:09 INFO - 'USER': 'cltbld', 11:01:09 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:09 INFO - '_': '/tools/buildbot/bin/python'} 11:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:01:09 INFO - Cleaning up... 11:01:09 INFO - Return code: 0 11:01:09 INFO - Running post-action listener: _resource_record_post_action 11:01:09 INFO - Running post-action listener: _start_resource_monitoring 11:01:09 INFO - Starting resource monitoring. 11:01:09 INFO - [mozharness: 2017-08-20 18:01:09.361737Z] Finished create-virtualenv step (success) 11:01:09 INFO - [mozharness: 2017-08-20 18:01:09.362256Z] Running install step. 11:01:09 INFO - Running pre-action listener: _resource_record_pre_action 11:01:09 INFO - Running main action method: install 11:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:09 INFO - Reading from file tmpfile_stdout 11:01:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:01:09 INFO - Reading from file tmpfile_stdout 11:01:09 INFO - Output received: 11:01:09 INFO - Usage: mozinstall [options] installer 11:01:09 INFO - Options: 11:01:09 INFO - -h, --help show this help message and exit 11:01:09 INFO - -d DEST, --destination=DEST 11:01:09 INFO - Directory to install application into. [default: 11:01:09 INFO - "/builds/slave/test"] 11:01:09 INFO - --app=APP Application being installed. [default: firefox] 11:01:09 INFO - mkdir: /builds/slave/test/build/application 11:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:01:27 INFO - Reading from file tmpfile_stdout 11:01:27 INFO - Output received: 11:01:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:01:27 INFO - Running post-action listener: _resource_record_post_action 11:01:27 INFO - [mozharness: 2017-08-20 18:01:27.931282Z] Finished install step (success) 11:01:27 INFO - [mozharness: 2017-08-20 18:01:27.931535Z] Running setup-mitmproxy step. 11:01:27 INFO - Running pre-action listener: _resource_record_pre_action 11:01:27 INFO - Running main action method: setup_mitmproxy 11:01:27 INFO - Skipping: mitmproxy is not required 11:01:27 INFO - Running post-action listener: _resource_record_post_action 11:01:27 INFO - [mozharness: 2017-08-20 18:01:27.932679Z] Finished setup-mitmproxy step (success) 11:01:27 INFO - [mozharness: 2017-08-20 18:01:27.932898Z] Running run-tests step. 11:01:27 INFO - Running pre-action listener: _resource_record_pre_action 11:01:27 INFO - Running pre-action listener: _set_gcov_prefix 11:01:27 INFO - Running main action method: run_tests 11:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:01:27 INFO - Python 2.7.3 11:01:27 INFO - Return code: 0 11:01:27 INFO - grabbing minidump binary from tooltool 11:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce130>, '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 0xfcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcf4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:01:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:01:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:01:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:01:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:28 INFO - Return code: 0 11:01:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:01:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:01:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:01:28 INFO - ENV: RUST_BACKTRACE is now full 11:01:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:01:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:01:28 INFO - Using env: {'DISPLAY': ':0', 11:01:28 INFO - 'HOME': '/home/cltbld', 11:01:28 INFO - 'LANG': 'en_US.UTF-8', 11:01:28 INFO - 'LANGUAGE': 'en_US:en', 11:01:28 INFO - 'LOGNAME': 'cltbld', 11:01:28 INFO - 'MAIL': '/var/mail/cltbld', 11:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:28 INFO - 'MOZ_NO_REMOTE': '1', 11:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:28 INFO - 'NO_EM_RESTART': '1', 11:01:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:28 INFO - 'PWD': '/builds/slave/test', 11:01:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:01:28 INFO - 'RUST_BACKTRACE': 'full', 11:01:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:01:28 INFO - 'SHELL': '/bin/bash', 11:01:28 INFO - 'SHLVL': '1', 11:01:28 INFO - 'STYLO_FORCE_ENABLED': '1', 11:01:28 INFO - 'TERM': 'linux', 11:01:28 INFO - 'TMOUT': '86400', 11:01:28 INFO - 'USER': 'cltbld', 11:01:28 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171', 11:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:28 INFO - '_': '/tools/buildbot/bin/python'} 11:01:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:01:28 INFO - mozversion application_buildid: 20170820170949 11:01:28 INFO - mozversion application_changeset: cab35526779367774b3ecea2f7a8a5c0993caa77 11:01:28 INFO - mozversion application_display_name: Nightly 11:01:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:28 INFO - mozversion application_name: Firefox 11:01:28 INFO - mozversion application_remotingname: firefox 11:01:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:01:28 INFO - mozversion application_vendor: Mozilla 11:01:28 INFO - mozversion application_version: 57.0a1 11:01:28 INFO - mozversion platform_buildid: 20170820170949 11:01:28 INFO - mozversion platform_changeset: cab35526779367774b3ecea2f7a8a5c0993caa77 11:01:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:01:28 INFO - mozversion platform_version: 57.0a1 11:01:28 INFO - using testdate: 1503252088 11:01:28 INFO - actual date: 1503252088 11:01:28 INFO - starting webserver on 'localhost:35642' 11:01:28 INFO - SUITE-START | Running 2 tests 11:01:28 INFO - TEST-START | dromaeo_css 11:01:28 INFO - Initialising browser for dromaeo_css test... 11:01:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35642/getInfo.html -profile /tmp/tmp0zRgEg/profile 11:01:28 INFO - TEST-INFO | started process 4000 (/builds/slave/test/build/application/firefox/firefox http://localhost:35642/getInfo.html) 11:01:34 INFO - TEST-INFO | 4000: exit 0 11:01:34 INFO - Browser initialized. 11:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:34 INFO - TEST-INFO | started process 4182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0zRgEg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:35 INFO - PID 4182 | 11:01:35 INFO - PID 4182 | (/builds/slave/test/build/application/firefox/firefox:4232): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:01:35 INFO - PID 4182 | 11:01:36 INFO - PID 4182 | 11:01:36 INFO - PID 4182 | (/builds/slave/test/build/application/firefox/firefox:4291): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:01:36 INFO - PID 4182 | 11:01:36 INFO - PID 4182 | __metrics Screen width/height:1600/1200 11:01:36 INFO - PID 4182 | colorDepth:24 11:01:36 INFO - PID 4182 | Browser inner width/height: 1024/768 11:01:36 INFO - PID 4182 | __metrics 11:01:46 INFO - PID 4182 | RSS: Main: 174403584 11:01:46 INFO - PID 4182 | 11:04:44 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35642/tests/dromaeo/cssquery-ext.html) 11:04:45 INFO - PID 4182 | RSS: Main: 178098176 11:04:45 INFO - PID 4182 | 11:07:47 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-ext.html (next: http://localhost:35642/tests/dromaeo/cssquery-jquery.html) 11:07:48 INFO - PID 4182 | RSS: Main: 174678016 11:07:48 INFO - PID 4182 | 11:10:50 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35642/tests/dromaeo/cssquery-mootools.html) 11:10:50 INFO - PID 4182 | RSS: Main: 176959488 11:10:50 INFO - PID 4182 | 11:13:52 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35642/tests/dromaeo/cssquery-prototype.html) 11:13:53 INFO - PID 4182 | RSS: Main: 175439872 11:13:53 INFO - PID 4182 | 11:16:56 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35642/tests/dromaeo/cssquery-yui.html) 11:16:57 INFO - PID 4182 | RSS: Main: 178741248 11:16:57 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | Cycle 1(1): loaded http://localhost:35642/tests/dromaeo/cssquery-yui.html (next: http://localhost:35642/tests/dromaeo/cssquery-dojo.html) 11:19:59 INFO - PID 4182 | RSS: Main: 179240960 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | __start_tp_report 11:19:59 INFO - PID 4182 | _x_x_mozilla_page_load 11:19:59 INFO - PID 4182 | _x_x_mozilla_page_load_details 11:19:59 INFO - PID 4182 | |i|pagename|runs| 11:19:59 INFO - PID 4182 | |0;dojo.html;3146.2449012237057;3166.889158879439;3177.634572024217;3192.7924684895465;3193.568868202792;6171.50627949764;6258.499320054396;6261.154744109544;6325.936740632604;6337.049442583609;6117.357677443871;6189.938100618992;6223.315435302113;6328.335524769902;6367.172267605205;5658.971705141489;5791.986402379567;5792.913106303409;5794.130880367937;5820.592558520905;583.5963471053229;5468.398476167638;5672.205891175238;5694.060480020791;5811.738471768781;5682.54539636828;5713.514351280146;5758.395368486291;5778;5783.624064435799;5695.857603559903;5697.658140511582;5781.277340332458;5789.768409263625;5795.130730390433;5650.632708873951;5666.263385759866;5748.48263656273;5767.192593036978;5782.855428614276;6030.638161710268;6113.083037544404;6165.0444181152;6186.907196392058;6244.406781355764;6473.83815404614;6482.31935646755;6503.219613646393;6571.408573228432;6585.176852893388;6474.4173024427555;6519.087327774116;6554.246261679872;6611.735530578771;6643.202815662152;6275.403836635513;6309.211348581427;6315.147455093549;6321.304656487782;6334.588251763713;6852.074969879102;6890.345417185359;6899.827504312332;6962.721491140399;6969.895451568231;6436.098946147543;6562.114114594468;6570.8357291068105;6618.7021584028835;6623.30455302196;6657.3342665733035;6709.7651582194385;6772.762953296611;6784.118064651564;6787.287334829871;6731;6749.32506749331;6753.594784312957;6775.661216939232;6787.728490860409;6605.141331626858;6614.900776488356;6623.271440141581;6635.900461493082;6789.15135608049;5164.2770012198325;5199.506046925536;5330.8933821324135;5360.892782144335;5373.817760092773;4583.977080114578;4586.380838586748;4614.353990441341;4628;4645.9303110453375;5548.69482178484;5647.858803529944;5700.515456186187;5723.570732195102;5794.942050579441;6778.525503214728;6794.3545363190415;6795.1845778506895;6802.489813264025;6811.318868113149;5752.165935939265;5773.307203135567;5811.186433899257;5824.126381042877;5839.678817665069;5915.231019967377;5942;5959.463648271676;6018.037114061816;6018.097285407224;6358.109864618957;6510.381513756186;6590.9670451647435;6600.372964568358;6600.471962243009;6675.666216689243;6696.83257918556;6783.660816959231;6789.660516974231;6790.694418751267;6422.325655806073;6428.871422571616;6468.191476065492;6500.642464664489;6546.378094081055;6516.022596610546;6549.181352330958;6554.442872355903;6620.172478440195;6636;6679.265280819009;6684.264730879502;6777.220619628806;6785;6795;6465.547411681326;6516.315786842313;6585.6377899216;6590.835229119119;6593.307702691149;6538.574992625464;6553.934460655523;6596.0435736816935;6623.205215374186;6625.668716564249;6426.260979987174;6439.06633538125;6442.677866106582;6527.477801775752;6528.836779080561;6432.260290066515;6535.411812936859;6536.934630653823;6632.369924857131;6646.268910419753;6366.840828979127;6415.647139407378;6418.871622567616;6440.935590644221;6443.162388889415 11:19:59 INFO - PID 4182 | |1;ext.html;781.7537475695156;826.1325608111483;851.6848765956601;852.4927668037517;1204.3135412814688;29959;30493.542596861065;40279.79860100699;41625.16749665012;41673.58326416735;41105.58894411055;41531.16937661245;41635.37546936798;41666;41681.79159104208;7251.093613298338;7696.191899850533;7945.880811787828;7951.64217610206;7953.721619743281;7786.065672119325;7885.645145968417;7887.369010479177;7888.487248328869;7891.644875980594;7874.212578742137;7930.762077137695;7933.0876949150725;7936.285734283913;7941.960290198541;7799.805004874866;7865.410094242926;7870.134285228621;7870.567118808463;7872.488288261245;7719.18948510404;7751.728689495841;7827.882581761278;7828;7828.099768526636;37896;37915;38001.80999095015;38017.239655206744;38169;3591.910202244939;3635.509206257148;3635.5455568053994;3643.125649844045;3647.94528082079;31420;31446.05661830149;31452.37095258105;31467.213319667193;31503.212419689462;5031.949680503185;5051.4695956924725;5083.923741143886;5118.25785261135;5120.257562653432;175764;176021.119894401;176024.11987939978;176069;176817;47243.763781180875;47375.5262447378;47379.526204737514;47463.52536474591;47518.76240618775;48921.75539122282;49003.75498122487;49192.754036230304;49251.50748492541;49451;14659.853401466062;16173.191340432932;16400.1799910004;16593.087380193963;16627.916860415862;12365.381730913597;13798.793018104736;14056.71886562263;14122.646933826736;14133.5053273137;14034.578962631138;14044.438222470986;14104.647383815487;14113.153210807384;14118.929405353112;5532.585056120807;5593.937151941118;5699.575106223444;5759.539236861125;5794.001069630971;1015.5125539740966;1026.609888242463;1039.2413538117066;1043.6973277749519;1046.474614037881;22557;23186.304410867702;28247;28974.32566134656;29228.415431691246;1107.4739498738195;1109.367660433545;1110.2339385823757;1124.5670416889393;1127.3179726265655;12679.429425675868;12941.288229147487;12942.158759680591;12992.415341309475;12995.15531490469;228408;230011;230477;230699;230734;51262.74368628133;51518.742406287725;51539;51649.741751291;51947.22079168815;1462.8390877003521;1469.4048910191175;1509.6678730679232;1516.219147139224;1533.2333833083458;23091;23108.76891231066;23279.41801454977;23319.76680233176;23386.415339616644;37943.05142371463;37943.81028094842;38035.42946855744;38078.048048799;38141;202708;203771;203834;204042;204043;34028;36731.44902826513;38304.23391532098;38453.230935381696;38480.80759596184;46559.53440465552;47814;48156.759216203696;48244.517554824;48511;34701;34970;34982.65017349794;35204.29591408209;35324;34959.825200873835;35010;35255.11862203466;35518.822405887804;35699.64300357067;36984.26031479301;37382.25235495329;37391;37424.812875935444;37443.25113497661;32886.50670239996;33743.831280844424;33772.662273376955;33897.830510847285;33931;25028.24915252545;25405.745942541078;25672.871635641703;25753.356166095997;25979.61030584505 11:19:59 INFO - PID 4182 | |2;jquery.html;570.1590154522083;570.8230448560946;580.8112363481869;582.5805420097528;603.191723091058;21400.143994240232;22295.554088918212;22331.218407355726;22333.888330558366;22340;24129.39676508088;25447.618285725683;26501.469970600625;26536;26689.733102668968;6329.398707122828;6462.741490340404;6467.223933128032;6477.676116194171;6483.837904052413;5884.794032208873;6336.651484168369;6385.904211436832;6404.519661025419;6421.261554921174;6350.84122896929;6375.8406039848915;6387.041943708435;6391.169148010776;6394.328595497475;6355.269144048448;6356.364363563653;6381.7766378176775;6385.265694445128;6385.936140638581;5903.881922361528;5927.229460170151;5953.58324917256;5966;5972.25346831646;28318.433631327465;29355;29834.403311933638;29894.402111957857;29966.55050174249;1922.259929926974;1974.0820518458986;1974.4175468236904;1975.575251320973;1976.456474469518;18980.5254868628;19511.902440487847;19803.900980495004;19859.80140198594;20081.497962550908;2197.2529340024466;2228.5542891421783;2253.6281513550243;2259.3222033389916;2274.226762900605;133677;135550;137060;137377.3131134338;138214.30892845674;14777.556673299818;15079.924600376928;15092.471763488225;15121.319540620698;15397.692046159014;23715.407114821923;23719;23804.166854160023;23870.403239918793;23873.970712489634;9816;9883.802323953625;9966.451845148586;10104.898951010542;10193;9096.408733432305;9181.081891810765;9232.53837308132;9343.439393636403;9344.065593440602;7971.561564113914;9021.594028268744;9209.585568649427;9268.119528644767;9364.438133711863;2525.431777849969;2594;2665.1338315047688;2667.1198504493473;2784.276088217038;950.538988590533;968.4915419404869;985.6057576969126;988.6243227573619;989.2877128467636;19386.385522330696;19775.901120494305;20128.798712012693;20486.692699609517;20732.06705698217;1040.1990467340106;1042.801867645145;1048.4652827058103;1049.0715716590719;1054.2567489919588;11007.889921100686;13532.391042402918;14132.434702611987;14198.29008549589;14355.210463424612;492527;493619;508971;511990;515338;111018.44490777495;121150;122009.38995304967;122867;123219.38390307991;1238.8141778733261;1246.077902352271;1266.0125102420127;1268.131330038908;1291.3156027305356;21485.248016319354;21536.138554457648;21544.569108617427;21628.567428651655;21706.782932170478;54430.183547247616;55500;56349;56785;57764;69743.65128174327;70129;70206.64896675484;70492;70691.29308706846;12684.302363370103;13212.603621891358;14208.502702405367;14629.70740585161;14690.485832995793;23298.184563540195;24280.271591852274;24506.754932450447;24517.877410613546;24588.50822983566;18730.625387491902;18863.90568047151;19108.808911910703;19196.616067678846;19211.135498902862;17288.65422691514;17306.653866922843;17640.29438822484;17759.911200443916;18112.366067187584;18097.457076287734;18234.544136396697;18435.446936591925;18689.813101868807;18721.689481736146;14645.92677036608;14653.92673036628;14667.48663796762;14668.853311466748;14694.779578306549;18015.72976405329;18386.908065459585;18444.446666599488;18462.723059154392;18474.722879157092 11:19:59 INFO - PID 4182 | |3;mootools.html;1353.4045020191115;1410.0341266232624;1421.950231741889;1423.0536693099089;1427.750143724848;13723.451061957523;13902.721945561083;14279.428822847087;14303.642408939782;14304.427822887084;14927.253637318145;15193.77209341858;15200.16399098049;15209.23953802311;15213.77179342308;2648.5497465430876;2708.079253053961;2709.498742732601;2721.4421043686098;2724.141895302983;2716.904908328209;2842.502562051643;2842.673092594347;2843.4597426489004;2844.345800465894;2711.200195942202;2749.670039595251;2757.6690797104375;2769.3492029373083;2772.7365900239447;2735.4665840161274;2742.5749008903654;2752.2018614601743;2759.18604011817;2761.765249953756;2621.8033647476514;2631.8551430127764;2640.392709676785;2640.6303117563557;2652.151311580295;14255;14479.855201447956;14514.274286285749;14539.491117810825;14576.489822856256;7604.391648668094;7909.090454597737;7922.960385198037;7933.523988560647;7968.7609371718945;5315.707636080014;5381.784728610851;5443.564514838803;5517.034518959166;5530.419305972895;1855.7216417537477;1858.433177880746;1862.087577087231;1865.7481240032694;1890.962180756391;24035.158769443162;24206.7579324208;24213.757862421327;24302.39244018896;24323.635145472832;6512.739490420425;6584.7366105356205;6622.933770662232;6740.629265390353;6815.7614483493835;16502.504924852274;16505.587360316087;16534.586635334213;16549.25528351203;16615.08617026075;7718.96140519305;7791.220877912277;7863.37093032556;7876.330511906437;7885.1326354101;5946.45096501177;7244.384227340735;7273.745418910418;7306.232845551247;7336.486445948733;5057.645964782503;5196.32447781786;5268.81559145428;5286;5352.464753524617;1410.9929450352683;1430.81399418075;1431.06980462698;1462.0715845438224;1463.1733070814955;887.0641473245788;907.1790030022839;908.7864351877304;915.7664795477244;926.1803304075942;7258.383037441771;7317.963410183022;7400.555966642019;7428.591427471541;7434.553926764412;731.3344856180956;740.2449501508431;741.4661443760592;741.5587725303436;746.3767753925533;5573.865452221164;5761.740721667535;5838.620489668158;5894.32215295238;5974.133750606225;20327.8983605084;20730.89634551848;20790.1683932641;20832.895835521027;21121.89439052795;19259.807401926082;20463.28378506745;20641.89679051625;20645.380638580868;20656.277030303867;11043.723906902393;11293.604723834625;11297.943510282395;11308.378039207922;11325.093992480583;8395.454295470774;8787.384883058381;8789.692360767342;8793.956030219808;9188.540572971458;17262;17332;17333.826661733725;17611.911940440215;17870.91064544669;17832.643347132725;17860.285588576313;17906.5523361917;18151.364702235358;18392.632147357246;12151.270923744603;12582.24506529611;12738.554150604685;13124.671883202996;13134.868651313365;13683.589492315246;14056.929715351358;14082.295885205904;14098.083624564371;14102.929485352917;11028.503717332578;11160.218784684994;11256.774864502828;11262.83105753398;11409.201355905006;10402.791944161227;10560.471976401303;10562.89437105619;10718.946405268236;10875.347479151276;9564.61741530331;9768.706938791847;9779.559919803769;9791.118799308097;9800.607975680892;7380.188179300165;7421.666025028994;7433.2195119513835;7442.702291908479;7479.775606731807;7361.153467351323;7372.63136843145;7407.666655000646;7409.259074092548;7484.176740558425 11:19:59 INFO - PID 4182 | |4;prototype.html;481.36219509150385;506.6200349737697;518.7950759450017;528.8915772266686;535.973201339933;6207.782727604535;6254.468370188533;6308.810735677931;6321.209848768904;6321.577645029872;6086.747903275783;6089.421504957033;6120.846978825532;6165.475934545558;6205.937940620593;5081.263216833566;5095.8216462423825;5142.922856157161;5170.327857378536;5175.689458632475;4965.826196083138;5036.169032109698;5116.795328186887;5125.794968201268;5166.881578552794;5165.870853228681;5206;5207.953347291839;5219.147202743028;5254.21186821976;5114.514121158521;5180.378354597435;5186.273921650972;5203.7398130093725;5211.530962213419;4799.832005879813;4832.178529649968;4854.514548545152;4867.732274724889;4869.732164730938;6119.847003824895;6148.6618235997;6150.261968563756;6181.3818618138275;6231.470325022333;5982.8504287392725;6023.247094113236;6036.788712395045;6046.455818976269;6047.134279748637;6584.407403333675;6615.37153970372;6646.435053020499;6687.197536295627;6749.628770417625;5242.169228616543;5290.55030322423;5301.363836339626;5313.734313284321;5332.466753324676;6636.767713130017;6745.224299205605;6821.192384018239;6973.965130174418;6991.685374158124;5447.346318441812;5459.945400546023;5492.780288788484;5513.5037846594;5513.751881165357;5515.227868098389;5518.255035570227;5561.860953476114;5567.498925096761;5617.297837770278;5911.231539899872;5999.580029397987;6008.798240351947;6022.5483088768515;6039.7282122304605;6577.572457790324;6621.271660117383;6635.5023373247195;6690.454059348553;6699.387238976803;1934.429343343717;1938.903054847252;1956.227290220355;1977.5155087003777;1977.604479104185;1404.2978510744629;1445.8481859404822;1449.4854326713864;1457.6938842843122;1457.6938842843122;5733.397993210653;5751.626144300607;5816.680082595413;5821.18503409523;5843.18195452637;6680.83297917556;6732.831679207961;6745.0556922030955;6768.221654509696;6791.626460544619;5742.019003443888;5759.280089988752;5771.624844385102;5840.510669779179;5845.1232315153065;3536.398812201932;3602.9731526514815;3620.4569314602495;3639.6178401268016;3669.743117981769;6492.740290388331;6527.510436717265;6610.207599490331;6623.3376662333385;6623.34416395901;6905.965470172718;6959.756408525677;6961.477889158232;7001.159860816734;7010.0021493874;6487.740490380332;6542.705578249085;6543.672816359068;6565.967170164214;6592.670366481752;6676.599404035774;6731.932680673131;6747.932520674927;6844.418224450778;6851.3491218334175;6647.476837276251;6680.565763225375;6699.789069607115;6705.497087718343;6713.690830288242;6530.314316996837;6535.901961470487;6563.9343606563325;6588.550518886029;6650.767223147167;5528.834134975797;5553.555715542666;5568.610197286151;5568.805091821767;5573.749181286771;6543.738250469928;6593.307702691341;6741.157355330583;6843.828904277433;6869.656517174221;6488.188976377953;6581.3418658133805;6587.571807832475;6613.966930165318;6665;6506.967465162644;6531.771388001397;6572.338203027782;6628.701708423229;6647.833804154935;6296.905546416899;6353.680906469198;6428.871422571616;6509.381608747161;6532.118164047793;6551.246606640298;6567.089619342439;6590.5716128451495;6609.537332386687;6691.728571571581;6395.808125756234;6399.200099987502;6423.96788016057;6426.710798014007;6430.421262086435 11:19:59 INFO - PID 4182 | |5;yui.html;895.4000819450968;915.2906497464464;929.4934260827848;937.6390089815424;937.8640097185909;18424.447266582007;19068.904655476705;19121;19138.61722765547;19212.903935480303;17438.389656361996;18355.908220458914;21945.890270548665;21981.890090549565;22144;1061.8247989081792;1074.6990842564055;1075.8171110911164;1077.0414331245197;1079.3416016230094;983.3165949664985;1050.8266136087536;1054.19880890523;1054.4991129213602;1060.8620879285681;1104.282216559235;1114.7213196700825;1118.8657361116677;1119.7088756923176;1120.6525976947173;1116.3246236027207;1119.2724728926182;1119.5242022140558;1119.9216054876163;1119.9720006999848;821.4414198345123;822.786075620343;822.9835403291961;823.0904850140628;824.8680211166245;19188;19318.517037074045;19351.12919918607;19420.4173874784;20093.598128037505;20739.27412540554;21390.14439422421;21928.89035554828;22419.775802241933;22448.775512244832;15837.92081039599;15947.840521594751;16035.679286414323;16094.436694715629;16228.837711622851;3673.3938900081453;3695.6489133532273;3696.2237930034726;3696.611855755134;3696.8706095286534;129243;130137;130905.34547327297;133133;133334.3333283337;16586.336546538005;17207.913960430116;17297.56756081108;17315.393961211295;17385.47843564695;32040;32118.518222226685;32723.83638081842;32743.345133097682;32836.67163328384;8674.696385626472;8763.91236087631;8942.418742781698;8976.551172441483;9008.954955225314;4237.300845360543;4304.612584867377;4316.309390497506;4350.564943505624;4353.6299414549485;5179.98990196908;5182.507661772125;5246.711430871339;5251.317328747238;5296.549793267615;1112.777444511085;1120.4117838135044;1124.983125253122;1125.836753670713;1128.9604863829727;696.5333226738097;700.7092056796372;712.3197346534048;717.4475653746586;723.1250187273353;11548.711282218012;11733.823992640117;11945.88054119465;12028.218165819193;12565.560205392767;632.3265722006049;643.2217017408988;675.6824292582478;697.2574208468067;731.4843035659848;5197.948020519822;5391.56867450603;5478.58910581708;5522.392536820947;5575.665460072409;108274.45862770636;110873.89126108636;111487.44256278829;111786;113641.43179284217;73476.63261683658;95201.52399238099;96651;97963.51018245006;104783;79312.60343698245;84756.57621711976;85907.57046214853;88027;91093;12377.690557736129;12397.380130993595;12834.358282086045;12846;13097.869021309665;39317.41023884701;40352.596474034886;40472;41259.587404125574;42217.36673949832;67125;67612.32387676061;69576;70923;74792.62603686946;19269.22923083061;19417.223311067963;19516.121774520463;19548.511287217934;19863;19834;20021.899890500456;20198.495037624176;20389.286374976804;20437.284695035603;17945.551361216076;18161.182746776693;18175.18211680504;18181.54546136357;18256.36102736398;18022;18048.639027219644;18090.819091808913;18099.09504524742;18338.174782135102;17474.82525174732;17529.1235438225;17578.73631895497;17592.824071759118;17693.469195924143;13759.656008599864;14022.22877741734;14190.716185676021;14207.289635517976;14314.928425357806;14613.253209831422;14665.48670796517;14691;14807.25963701789;14883.776743348642 11:19:59 INFO - PID 4182 | __end_tp_report 11:19:59 INFO - PID 4182 | __start_cc_report 11:19:59 INFO - PID 4182 | _x_x_mozilla_cycle_collect,384 11:19:59 INFO - PID 4182 | __end_cc_report 11:19:59 INFO - PID 4182 | __startTimestamp1503253199367__endTimestamp 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | ------- Summary: start ------- 11:19:59 INFO - PID 4182 | Number of tests: 6 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#0] dojo.html Cycles:165 Average:6130.52 Median:6432.26 stddev:851.94 (13.2%) stddev-sans-first:821.76 11:19:59 INFO - PID 4182 | Values: 3146.2 3166.9 3177.6 3192.8 3193.6 6171.5 6258.5 6261.2 6325.9 6337.0 6117.4 6189.9 6223.3 6328.3 6367.2 5659.0 5792.0 5792.9 5794.1 5820.6 583.6 5468.4 5672.2 5694.1 5811.7 5682.5 5713.5 5758.4 5778.0 5783.6 5695.9 5697.7 5781.3 5789.8 5795.1 5650.6 5666.3 5748.5 5767.2 5782.9 6030.6 6113.1 6165.0 6186.9 6244.4 6473.8 6482.3 6503.2 6571.4 6585.2 6474.4 6519.1 6554.2 6611.7 6643.2 6275.4 6309.2 6315.1 6321.3 6334.6 6852.1 6890.3 6899.8 6962.7 6969.9 6436.1 6562.1 6570.8 6618.7 6623.3 6657.3 6709.8 6772.8 6784.1 6787.3 6731.0 6749.3 6753.6 6775.7 6787.7 6605.1 6614.9 6623.3 6635.9 6789.2 5164.3 5199.5 5330.9 5360.9 5373.8 4584.0 4586.4 4614.4 4628.0 4645.9 5548.7 5647.9 5700.5 5723.6 5794.9 6778.5 6794.4 6795.2 6802.5 6811.3 5752.2 5773.3 5811.2 5824.1 5839.7 5915.2 5942.0 5959.5 6018.0 6018.1 6358.1 6510.4 6591.0 6600.4 6600.5 6675.7 6696.8 6783.7 6789.7 6790.7 6422.3 6428.9 6468.2 6500.6 6546.4 6516.0 6549.2 6554.4 6620.2 6636.0 6679.3 6684.3 6777.2 6785.0 6795.0 6465.5 6516.3 6585.6 6590.8 6593.3 6538.6 6553.9 6596.0 6623.2 6625.7 6426.3 6439.1 6442.7 6527.5 6528.8 6432.3 6535.4 6536.9 6632.4 6646.3 6366.8 6415.6 6418.9 6440.9 6443.2 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#1] ext.html Cycles:180 Average:37787.72 Median:3635.53 stddev:52884.17 (1454.6%) stddev-sans-first:52959.52 11:19:59 INFO - PID 4182 | Values: 781.8 826.1 851.7 852.5 1204.3 29959.0 30493.5 40279.8 41625.2 41673.6 41105.6 41531.2 41635.4 41666.0 41681.8 7251.1 7696.2 7945.9 7951.6 7953.7 7786.1 7885.6 7887.4 7888.5 7891.6 7874.2 7930.8 7933.1 7936.3 7942.0 7799.8 7865.4 7870.1 7870.6 7872.5 7719.2 7751.7 7827.9 7828.0 7828.1 37896.0 37915.0 38001.8 38017.2 38169.0 3591.9 3635.5 3635.5 3643.1 3647.9 31420.0 31446.1 31452.4 31467.2 31503.2 5031.9 5051.5 5083.9 5118.3 5120.3 175764.0 176021.1 176024.1 176069.0 176817.0 47243.8 47375.5 47379.5 47463.5 47518.8 48921.8 49003.8 49192.8 49251.5 49451.0 14659.9 16173.2 16400.2 16593.1 16627.9 12365.4 13798.8 14056.7 14122.6 14133.5 14034.6 14044.4 14104.6 14113.2 14118.9 5532.6 5593.9 5699.6 5759.5 5794.0 1015.5 1026.6 1039.2 1043.7 1046.5 22557.0 23186.3 28247.0 28974.3 29228.4 1107.5 1109.4 1110.2 1124.6 1127.3 12679.4 12941.3 12942.2 12992.4 12995.2 228408.0 230011.0 230477.0 230699.0 230734.0 51262.7 51518.7 51539.0 51649.7 51947.2 1462.8 1469.4 1509.7 1516.2 1533.2 23091.0 23108.8 23279.4 23319.8 23386.4 37943.1 37943.8 38035.4 38078.0 38141.0 202708.0 203771.0 203834.0 204042.0 204043.0 34028.0 36731.4 38304.2 38453.2 38480.8 46559.5 47814.0 48156.8 48244.5 48511.0 34701.0 34970.0 34982.7 35204.3 35324.0 34959.8 35010.0 35255.1 35518.8 35699.6 36984.3 37382.3 37391.0 37424.8 37443.3 32886.5 33743.8 33772.7 33897.8 33931.0 25028.2 25405.7 25672.9 25753.4 25979.6 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#2] jquery.html Cycles:180 Average:35418.08 Median:2266.77 stddev:84835.91 (3742.6%) stddev-sans-first:85033.55 11:19:59 INFO - PID 4182 | Values: 570.2 570.8 580.8 582.6 603.2 21400.1 22295.6 22331.2 22333.9 22340.0 24129.4 25447.6 26501.5 26536.0 26689.7 6329.4 6462.7 6467.2 6477.7 6483.8 5884.8 6336.7 6385.9 6404.5 6421.3 6350.8 6375.8 6387.0 6391.2 6394.3 6355.3 6356.4 6381.8 6385.3 6385.9 5903.9 5927.2 5953.6 5966.0 5972.3 28318.4 29355.0 29834.4 29894.4 29966.6 1922.3 1974.1 1974.4 1975.6 1976.5 18980.5 19511.9 19803.9 19859.8 20081.5 2197.3 2228.6 2253.6 2259.3 2274.2 133677.0 135550.0 137060.0 137377.3 138214.3 14777.6 15079.9 15092.5 15121.3 15397.7 23715.4 23719.0 23804.2 23870.4 23874.0 9816.0 9883.8 9966.5 10104.9 10193.0 9096.4 9181.1 9232.5 9343.4 9344.1 7971.6 9021.6 9209.6 9268.1 9364.4 2525.4 2594.0 2665.1 2667.1 2784.3 950.5 968.5 985.6 988.6 989.3 19386.4 19775.9 20128.8 20486.7 20732.1 1040.2 1042.8 1048.5 1049.1 1054.3 11007.9 13532.4 14132.4 14198.3 14355.2 492527.0 493619.0 508971.0 511990.0 515338.0 111018.4 121150.0 122009.4 122867.0 123219.4 1238.8 1246.1 1266.0 1268.1 1291.3 21485.2 21536.1 21544.6 21628.6 21706.8 54430.2 55500.0 56349.0 56785.0 57764.0 69743.7 70129.0 70206.6 70492.0 70691.3 12684.3 13212.6 14208.5 14629.7 14690.5 23298.2 24280.3 24506.8 24517.9 24588.5 18730.6 18863.9 19108.8 19196.6 19211.1 17288.7 17306.7 17640.3 17759.9 18112.4 18097.5 18234.5 18435.4 18689.8 18721.7 14645.9 14653.9 14667.5 14668.9 14694.8 18015.7 18386.9 18444.4 18462.7 18474.7 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#3] mootools.html Cycles:180 Average:9098.63 Median:2680.12 stddev:6271.94 (234.0%) stddev-sans-first:6262.53 11:19:59 INFO - PID 4182 | Values: 1353.4 1410.0 1422.0 1423.1 1427.8 13723.5 13902.7 14279.4 14303.6 14304.4 14927.3 15193.8 15200.2 15209.2 15213.8 2648.5 2708.1 2709.5 2721.4 2724.1 2716.9 2842.5 2842.7 2843.5 2844.3 2711.2 2749.7 2757.7 2769.3 2772.7 2735.5 2742.6 2752.2 2759.2 2761.8 2621.8 2631.9 2640.4 2640.6 2652.2 14255.0 14479.9 14514.3 14539.5 14576.5 7604.4 7909.1 7923.0 7933.5 7968.8 5315.7 5381.8 5443.6 5517.0 5530.4 1855.7 1858.4 1862.1 1865.7 1891.0 24035.2 24206.8 24213.8 24302.4 24323.6 6512.7 6584.7 6622.9 6740.6 6815.8 16502.5 16505.6 16534.6 16549.3 16615.1 7719.0 7791.2 7863.4 7876.3 7885.1 5946.5 7244.4 7273.7 7306.2 7336.5 5057.6 5196.3 5268.8 5286.0 5352.5 1411.0 1430.8 1431.1 1462.1 1463.2 887.1 907.2 908.8 915.8 926.2 7258.4 7318.0 7400.6 7428.6 7434.6 731.3 740.2 741.5 741.6 746.4 5573.9 5761.7 5838.6 5894.3 5974.1 20327.9 20730.9 20790.2 20832.9 21121.9 19259.8 20463.3 20641.9 20645.4 20656.3 11043.7 11293.6 11297.9 11308.4 11325.1 8395.5 8787.4 8789.7 8794.0 9188.5 17262.0 17332.0 17333.8 17611.9 17870.9 17832.6 17860.3 17906.6 18151.4 18392.6 12151.3 12582.2 12738.6 13124.7 13134.9 13683.6 14056.9 14082.3 14098.1 14102.9 11028.5 11160.2 11256.8 11262.8 11409.2 10402.8 10560.5 10562.9 10718.9 10875.3 9564.6 9768.7 9779.6 9791.1 9800.6 7380.2 7421.7 7433.2 7442.7 7479.8 7361.2 7372.6 7407.7 7409.3 7484.2 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#4] prototype.html Cycles:180 Average:5649.80 Median:6157.87 stddev:1505.49 (24.4%) stddev-sans-first:1458.88 11:19:59 INFO - PID 4182 | Values: 481.4 506.6 518.8 528.9 536.0 6207.8 6254.5 6308.8 6321.2 6321.6 6086.7 6089.4 6120.8 6165.5 6205.9 5081.3 5095.8 5142.9 5170.3 5175.7 4965.8 5036.2 5116.8 5125.8 5166.9 5165.9 5206.0 5208.0 5219.1 5254.2 5114.5 5180.4 5186.3 5203.7 5211.5 4799.8 4832.2 4854.5 4867.7 4869.7 6119.8 6148.7 6150.3 6181.4 6231.5 5982.9 6023.2 6036.8 6046.5 6047.1 6584.4 6615.4 6646.4 6687.2 6749.6 5242.2 5290.6 5301.4 5313.7 5332.5 6636.8 6745.2 6821.2 6974.0 6991.7 5447.3 5459.9 5492.8 5513.5 5513.8 5515.2 5518.3 5561.9 5567.5 5617.3 5911.2 5999.6 6008.8 6022.5 6039.7 6577.6 6621.3 6635.5 6690.5 6699.4 1934.4 1938.9 1956.2 1977.5 1977.6 1404.3 1445.8 1449.5 1457.7 1457.7 5733.4 5751.6 5816.7 5821.2 5843.2 6680.8 6732.8 6745.1 6768.2 6791.6 5742.0 5759.3 5771.6 5840.5 5845.1 3536.4 3603.0 3620.5 3639.6 3669.7 6492.7 6527.5 6610.2 6623.3 6623.3 6906.0 6959.8 6961.5 7001.2 7010.0 6487.7 6542.7 6543.7 6566.0 6592.7 6676.6 6731.9 6747.9 6844.4 6851.3 6647.5 6680.6 6699.8 6705.5 6713.7 6530.3 6535.9 6563.9 6588.6 6650.8 5528.8 5553.6 5568.6 5568.8 5573.7 6543.7 6593.3 6741.2 6843.8 6869.7 6488.2 6581.3 6587.6 6614.0 6665.0 6507.0 6531.8 6572.3 6628.7 6647.8 6296.9 6353.7 6428.9 6509.4 6532.1 6551.2 6567.1 6590.6 6609.5 6691.7 6395.8 6399.2 6424.0 6426.7 6430.4 11:19:59 INFO - PID 4182 | 11:19:59 INFO - PID 4182 | [#5] yui.html Cycles:180 Average:23950.61 Median:19384.18 stddev:32448.36 (167.4%) stddev-sans-first:32493.20 11:19:59 INFO - PID 4182 | Values: 895.4 915.3 929.5 937.6 937.9 18424.4 19068.9 19121.0 19138.6 19212.9 17438.4 18355.9 21945.9 21981.9 22144.0 1061.8 1074.7 1075.8 1077.0 1079.3 983.3 1050.8 1054.2 1054.5 1060.9 1104.3 1114.7 1118.9 1119.7 1120.7 1116.3 1119.3 1119.5 1119.9 1120.0 821.4 822.8 823.0 823.1 824.9 19188.0 19318.5 19351.1 19420.4 20093.6 20739.3 21390.1 21928.9 22419.8 22448.8 15837.9 15947.8 16035.7 16094.4 16228.8 3673.4 3695.6 3696.2 3696.6 3696.9 129243.0 130137.0 130905.3 133133.0 133334.3 16586.3 17207.9 17297.6 17315.4 17385.5 32040.0 32118.5 32723.8 32743.3 32836.7 8674.7 8763.9 8942.4 8976.6 9009.0 4237.3 4304.6 4316.3 4350.6 4353.6 5180.0 5182.5 5246.7 5251.3 5296.5 1112.8 1120.4 1125.0 1125.8 1129.0 696.5 700.7 712.3 717.4 723.1 11548.7 11733.8 11945.9 12028.2 12565.6 632.3 643.2 675.7 697.3 731.5 5197.9 5391.6 5478.6 5522.4 5575.7 108274.5 110873.9 111487.4 111786.0 113641.4 73476.6 95201.5 96651.0 97963.5 104783.0 79312.6 84756.6 85907.6 88027.0 91093.0 12377.7 12397.4 12834.4 12846.0 13097.9 39317.4 40352.6 40472.0 41259.6 42217.4 67125.0 67612.3 69576.0 70923.0 74792.6 19269.2 19417.2 19516.1 19548.5 19863.0 19834.0 20021.9 20198.5 20389.3 20437.3 17945.6 18161.2 18175.2 18181.5 18256.4 18022.0 18048.6 18090.8 18099.1 18338.2 17474.8 17529.1 17578.7 17592.8 17693.5 13759.7 14022.2 14190.7 14207.3 14314.9 14613.3 14665.5 14691.0 14807.3 14883.8 11:19:59 INFO - PID 4182 | -------- Summary: end -------- 11:19:59 INFO - PID 4182 | 11:20:00 INFO - TEST-INFO | 4182: exit 0 11:20:00 INFO - TEST-OK | dromaeo_css | took 1111763ms 11:20:00 INFO - TEST-START | kraken 11:20:00 INFO - Initialising browser for kraken test... 11:20:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35642/getInfo.html -profile /tmp/tmpMn0CEv/profile 11:20:00 INFO - TEST-INFO | started process 4607 (/builds/slave/test/build/application/firefox/firefox http://localhost:35642/getInfo.html) 11:20:06 INFO - TEST-INFO | 4607: exit 0 11:20:06 INFO - Browser initialized. 11:20:06 INFO - Running cycle 1/1 for kraken test... 11:20:06 INFO - TEST-INFO | started process 4844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMn0CEv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:07 INFO - PID 4844 | 11:20:07 INFO - PID 4844 | (/builds/slave/test/build/application/firefox/firefox:4894): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:20:07 INFO - PID 4844 | 11:20:07 INFO - PID 4844 | 11:20:07 INFO - PID 4844 | (/builds/slave/test/build/application/firefox/firefox:4953): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:20:07 INFO - PID 4844 | 11:20:07 INFO - PID 4844 | __metrics Screen width/height:1600/1200 11:20:07 INFO - PID 4844 | colorDepth:24 11:20:07 INFO - PID 4844 | Browser inner width/height: 1024/768 11:20:07 INFO - PID 4844 | __metrics 11:20:17 INFO - PID 4844 | RSS: Main: 174350336 11:20:17 INFO - PID 4844 | 11:20:20 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35642/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:21 INFO - PID 4844 | RSS: Main: 178339840 11:20:21 INFO - PID 4844 | 11:20:23 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35642/tests/kraken/driver.html?testName=audio-dft) 11:20:24 INFO - PID 4844 | RSS: Main: 178728960 11:20:24 INFO - PID 4844 | 11:20:27 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35642/tests/kraken/driver.html?testName=audio-fft) 11:20:28 INFO - PID 4844 | RSS: Main: 173334528 11:20:28 INFO - PID 4844 | 11:20:30 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35642/tests/kraken/driver.html?testName=audio-oscillator) 11:20:31 INFO - PID 4844 | RSS: Main: 174284800 11:20:31 INFO - PID 4844 | 11:20:33 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35642/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:33 INFO - PID 4844 | RSS: Main: 174653440 11:20:33 INFO - PID 4844 | 11:20:36 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35642/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:37 INFO - PID 4844 | RSS: Main: 175566848 11:20:37 INFO - PID 4844 | 11:20:41 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35642/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:41 INFO - PID 4844 | RSS: Main: 175284224 11:20:41 INFO - PID 4844 | 11:20:44 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35642/tests/kraken/driver.html?testName=json-parse-financial) 11:20:45 INFO - PID 4844 | RSS: Main: 175554560 11:20:45 INFO - PID 4844 | 11:20:46 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35642/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:47 INFO - PID 4844 | RSS: Main: 175931392 11:20:47 INFO - PID 4844 | 11:20:49 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:50 INFO - PID 4844 | RSS: Main: 176103424 11:20:50 INFO - PID 4844 | 11:20:52 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:52 INFO - PID 4844 | RSS: Main: 176091136 11:20:52 INFO - PID 4844 | 11:20:55 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:56 INFO - PID 4844 | RSS: Main: 176238592 11:20:56 INFO - PID 4844 | 11:20:59 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:59 INFO - PID 4844 | RSS: Main: 176594944 11:20:59 INFO - PID 4844 | 11:21:01 INFO - PID 4844 | Cycle 1(1): loaded http://localhost:35642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35642/tests/kraken/driver.html?testName=ai-astar) 11:21:02 INFO - PID 4844 | RSS: Main: 178339840 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | __start_tp_report 11:21:02 INFO - PID 4844 | _x_x_mozilla_page_load 11:21:02 INFO - PID 4844 | _x_x_mozilla_page_load_details 11:21:02 INFO - PID 4844 | |i|pagename|runs| 11:21:02 INFO - PID 4844 | |0;ai-astar;98;107;99;107;113;115;109;100;108;107 11:21:02 INFO - PID 4844 | |1;audio-beat-detection;145;124;149;174;117;146;156;120;167;117 11:21:02 INFO - PID 4844 | |2;audio-dft;166;165;161;165;164;164;162;174;165;165 11:21:02 INFO - PID 4844 | |3;audio-fft;75;79;76;172;75;74;74;81;97;77 11:21:02 INFO - PID 4844 | |4;audio-oscillator;82;82;139;80;79;78;131;79;79;134 11:21:02 INFO - PID 4844 | |5;imaging-gaussian-blur;113;115;113;113;114;115;114;114;119;114 11:21:02 INFO - PID 4844 | |6;imaging-darkroom;151;151;150;155;150;150;150;153;153;152 11:21:02 INFO - PID 4844 | |7;imaging-desaturate;99;99;98;99;99;98;99;94;98;94 11:21:02 INFO - PID 4844 | |8;json-parse-financial;55;55;55;55;55;55;56;55;57;62 11:21:02 INFO - PID 4844 | |9;json-stringify-tinderbox;62;54;56;55;55;53;54;54;56;56 11:21:02 INFO - PID 4844 | |10;stanford-crypto-aes;79;75;79;76;75;75;80;78;75;80 11:21:02 INFO - PID 4844 | |11;stanford-crypto-ccm;122;120;121;133;123;120;120;127;125;153 11:21:02 INFO - PID 4844 | |12;stanford-crypto-pbkdf2;190;174;172;176;178;169;172;169;175;171 11:21:02 INFO - PID 4844 | |13;stanford-crypto-sha256-iterative;71;69;69;67;71;70;67;68;67;73 11:21:02 INFO - PID 4844 | __end_tp_report 11:21:02 INFO - PID 4844 | __start_cc_report 11:21:02 INFO - PID 4844 | _x_x_mozilla_cycle_collect,958 11:21:02 INFO - PID 4844 | __end_cc_report 11:21:02 INFO - PID 4844 | __startTimestamp1503253262055__endTimestamp 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | ------- Summary: start ------- 11:21:02 INFO - PID 4844 | Number of tests: 14 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#0] ai-astar Cycles:10 Average:106.30 Median:111.00 stddev:5.72 (5.1%) stddev-sans-first:5.21 11:21:02 INFO - PID 4844 | Values: 98.0 107.0 99.0 107.0 113.0 115.0 109.0 100.0 108.0 107.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:21.01 (14.2%) stddev-sans-first:22.25 11:21:02 INFO - PID 4844 | Values: 145.0 124.0 149.0 174.0 117.0 146.0 156.0 120.0 167.0 117.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.48 (2.1%) stddev-sans-first:3.67 11:21:02 INFO - PID 4844 | Values: 166.0 165.0 161.0 165.0 164.0 164.0 162.0 174.0 165.0 165.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#3] audio-fft Cycles:10 Average:88.00 Median:76.50 stddev:30.30 (39.6%) stddev-sans-first:31.77 11:21:02 INFO - PID 4844 | Values: 75.0 79.0 76.0 172.0 75.0 74.0 74.0 81.0 97.0 77.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:79.00 stddev:26.58 (33.6%) stddev-sans-first:27.68 11:21:02 INFO - PID 4844 | Values: 82.0 82.0 139.0 80.0 79.0 78.0 131.0 79.0 79.0 134.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.78 (1.6%) stddev-sans-first:1.81 11:21:02 INFO - PID 4844 | Values: 113.0 115.0 113.0 113.0 114.0 115.0 114.0 114.0 119.0 114.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:1.72 (1.1%) stddev-sans-first:1.81 11:21:02 INFO - PID 4844 | Values: 151.0 151.0 150.0 155.0 150.0 150.0 150.0 153.0 153.0 152.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:99.00 stddev:2.00 (2.0%) stddev-sans-first:2.07 11:21:02 INFO - PID 4844 | Values: 99.0 99.0 98.0 99.0 99.0 98.0 99.0 94.0 98.0 94.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.00 stddev:2.21 (4.0%) stddev-sans-first:2.32 11:21:02 INFO - PID 4844 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 57.0 62.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:2.51 (4.5%) stddev-sans-first:1.09 11:21:02 INFO - PID 4844 | Values: 62.0 54.0 56.0 55.0 55.0 53.0 54.0 54.0 56.0 56.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:78.50 stddev:2.20 (2.8%) stddev-sans-first:2.24 11:21:02 INFO - PID 4844 | Values: 79.0 75.0 79.0 76.0 75.0 75.0 80.0 78.0 75.0 80.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.00 stddev:10.20 (8.2%) stddev-sans-first:10.69 11:21:02 INFO - PID 4844 | Values: 122.0 120.0 121.0 133.0 123.0 120.0 120.0 127.0 125.0 153.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:6.15 (3.5%) stddev-sans-first:3.10 11:21:02 INFO - PID 4844 | Values: 190.0 174.0 172.0 176.0 178.0 169.0 172.0 169.0 175.0 171.0 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.04 (2.9%) stddev-sans-first:2.06 11:21:02 INFO - PID 4844 | Values: 71.0 69.0 69.0 67.0 71.0 70.0 67.0 68.0 67.0 73.0 11:21:02 INFO - PID 4844 | -------- Summary: end -------- 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:21:02 INFO - PID 4844 | 11:21:02 INFO - PID 4844 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:21:02 INFO - TEST-INFO | 4844: exit 0 11:21:02 INFO - TEST-OK | kraken | took 62686ms 11:21:02 INFO - SUITE-END | took 1174s 11:21:03 INFO - Completed test suite (00:19:34) 11:21:03 INFO - javascript benchmark 11:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8618.727821482225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.2449012237057, 3166.889158879439, 3177.634572024217, 3192.7924684895465, 3193.568868202792, 6171.50627949764, 6258.499320054396, 6261.154744109544, 6325.936740632604, 6337.049442583609, 6117.357677443871, 6189.938100618992, 6223.315435302113, 6328.335524769902, 6367.172267605205, 5658.971705141489, 5791.986402379567, 5792.913106303409, 5794.130880367937, 5820.592558520905, 583.5963471053229, 5468.398476167638, 5672.205891175238, 5694.060480020791, 5811.738471768781, 5682.54539636828, 5713.514351280146, 5758.395368486291, 5778.0, 5783.624064435799, 5695.857603559903, 5697.658140511582, 5781.277340332458, 5789.768409263625, 5795.130730390433, 5650.632708873951, 5666.263385759866, 5748.48263656273, 5767.192593036978, 5782.855428614276, 6030.638161710268, 6113.083037544404, 6165.0444181152, 6186.907196392058, 6244.406781355764, 6473.83815404614, 6482.31935646755, 6503.219613646393, 6571.408573228432, 6585.176852893388, 6474.4173024427555, 6519.087327774116, 6554.246261679872, 6611.735530578771, 6643.202815662152, 6275.403836635513, 6309.211348581427, 6315.147455093549, 6321.304656487782, 6334.588251763713, 6852.074969879102, 6890.345417185359, 6899.827504312332, 6962.721491140399, 6969.895451568231, 6436.098946147543, 6562.114114594468, 6570.8357291068105, 6618.7021584028835, 6623.30455302196, 6657.3342665733035, 6709.7651582194385, 6772.762953296611, 6784.118064651564, 6787.287334829871, 6731.0, 6749.32506749331, 6753.594784312957, 6775.661216939232, 6787.728490860409, 6605.141331626858, 6614.900776488356, 6623.271440141581, 6635.900461493082, 6789.15135608049, 5164.2770012198325, 5199.506046925536, 5330.8933821324135, 5360.892782144335, 5373.817760092773, 4583.977080114578, 4586.380838586748, 4614.353990441341, 4628.0, 4645.9303110453375, 5548.69482178484, 5647.858803529944, 5700.515456186187, 5723.570732195102, 5794.942050579441, 6778.525503214728, 6794.3545363190415, 6795.1845778506895, 6802.489813264025, 6811.318868113149, 5752.165935939265, 5773.307203135567, 5811.186433899257, 5824.126381042877, 5839.678817665069, 5915.231019967377, 5942.0, 5959.463648271676, 6018.037114061816, 6018.097285407224, 6358.109864618957, 6510.381513756186, 6590.9670451647435, 6600.372964568358, 6600.471962243009, 6675.666216689243, 6696.83257918556, 6783.660816959231, 6789.660516974231, 6790.694418751267, 6422.325655806073, 6428.871422571616, 6468.191476065492, 6500.642464664489, 6546.378094081055, 6516.022596610546, 6549.181352330958, 6554.442872355903, 6620.172478440195, 6636.0, 6679.265280819009, 6684.264730879502, 6777.220619628806, 6785.0, 6795.0, 6465.547411681326, 6516.315786842313, 6585.6377899216, 6590.835229119119, 6593.307702691149, 6538.574992625464, 6553.934460655523, 6596.0435736816935, 6623.205215374186, 6625.668716564249, 6426.260979987174, 6439.06633538125, 6442.677866106582, 6527.477801775752, 6528.836779080561, 6432.260290066515, 6535.411812936859, 6536.934630653823, 6632.369924857131, 6646.268910419753, 6366.840828979127, 6415.647139407378, 6418.871622567616, 6440.935590644221, 6443.162388889415], "value": 6069.516195455068, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.7537475695156, 826.1325608111483, 851.6848765956601, 852.4927668037517, 1204.3135412814688, 29959.0, 30493.542596861065, 40279.79860100699, 41625.16749665012, 41673.58326416735, 41105.58894411055, 41531.16937661245, 41635.37546936798, 41666.0, 41681.79159104208, 7251.093613298338, 7696.191899850533, 7945.880811787828, 7951.64217610206, 7953.721619743281, 7786.065672119325, 7885.645145968417, 7887.369010479177, 7888.487248328869, 7891.644875980594, 7874.212578742137, 7930.762077137695, 7933.0876949150725, 7936.285734283913, 7941.960290198541, 7799.805004874866, 7865.410094242926, 7870.134285228621, 7870.567118808463, 7872.488288261245, 7719.18948510404, 7751.728689495841, 7827.882581761278, 7828.0, 7828.099768526636, 37896.0, 37915.0, 38001.80999095015, 38017.239655206744, 38169.0, 3591.910202244939, 3635.509206257148, 3635.5455568053994, 3643.125649844045, 3647.94528082079, 31420.0, 31446.05661830149, 31452.37095258105, 31467.213319667193, 31503.212419689462, 5031.949680503185, 5051.4695956924725, 5083.923741143886, 5118.25785261135, 5120.257562653432, 175764.0, 176021.119894401, 176024.11987939978, 176069.0, 176817.0, 47243.763781180875, 47375.5262447378, 47379.526204737514, 47463.52536474591, 47518.76240618775, 48921.75539122282, 49003.75498122487, 49192.754036230304, 49251.50748492541, 49451.0, 14659.853401466062, 16173.191340432932, 16400.1799910004, 16593.087380193963, 16627.916860415862, 12365.381730913597, 13798.793018104736, 14056.71886562263, 14122.646933826736, 14133.5053273137, 14034.578962631138, 14044.438222470986, 14104.647383815487, 14113.153210807384, 14118.929405353112, 5532.585056120807, 5593.937151941118, 5699.575106223444, 5759.539236861125, 5794.001069630971, 1015.5125539740966, 1026.609888242463, 1039.2413538117066, 1043.6973277749519, 1046.474614037881, 22557.0, 23186.304410867702, 28247.0, 28974.32566134656, 29228.415431691246, 1107.4739498738195, 1109.367660433545, 1110.2339385823757, 1124.5670416889393, 1127.3179726265655, 12679.429425675868, 12941.288229147487, 12942.158759680591, 12992.415341309475, 12995.15531490469, 228408.0, 230011.0, 230477.0, 230699.0, 230734.0, 51262.74368628133, 51518.742406287725, 51539.0, 51649.741751291, 51947.22079168815, 1462.8390877003521, 1469.4048910191175, 1509.6678730679232, 1516.219147139224, 1533.2333833083458, 23091.0, 23108.76891231066, 23279.41801454977, 23319.76680233176, 23386.415339616644, 37943.05142371463, 37943.81028094842, 38035.42946855744, 38078.048048799, 38141.0, 202708.0, 203771.0, 203834.0, 204042.0, 204043.0, 34028.0, 36731.44902826513, 38304.23391532098, 38453.230935381696, 38480.80759596184, 46559.53440465552, 47814.0, 48156.759216203696, 48244.517554824, 48511.0, 34701.0, 34970.0, 34982.65017349794, 35204.29591408209, 35324.0, 34959.825200873835, 35010.0, 35255.11862203466, 35518.822405887804, 35699.64300357067, 36984.26031479301, 37382.25235495329, 37391.0, 37424.812875935444, 37443.25113497661, 32886.50670239996, 33743.831280844424, 33772.662273376955, 33897.830510847285, 33931.0, 25028.24915252545, 25405.745942541078, 25672.871635641703, 25753.356166095997, 25979.61030584505], "value": 17518.04520077428, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1590154522083, 570.8230448560946, 580.8112363481869, 582.5805420097528, 603.191723091058, 21400.143994240232, 22295.554088918212, 22331.218407355726, 22333.888330558366, 22340.0, 24129.39676508088, 25447.618285725683, 26501.469970600625, 26536.0, 26689.733102668968, 6329.398707122828, 6462.741490340404, 6467.223933128032, 6477.676116194171, 6483.837904052413, 5884.794032208873, 6336.651484168369, 6385.904211436832, 6404.519661025419, 6421.261554921174, 6350.84122896929, 6375.8406039848915, 6387.041943708435, 6391.169148010776, 6394.328595497475, 6355.269144048448, 6356.364363563653, 6381.7766378176775, 6385.265694445128, 6385.936140638581, 5903.881922361528, 5927.229460170151, 5953.58324917256, 5966.0, 5972.25346831646, 28318.433631327465, 29355.0, 29834.403311933638, 29894.402111957857, 29966.55050174249, 1922.259929926974, 1974.0820518458986, 1974.4175468236904, 1975.575251320973, 1976.456474469518, 18980.5254868628, 19511.902440487847, 19803.900980495004, 19859.80140198594, 20081.497962550908, 2197.2529340024466, 2228.5542891421783, 2253.6281513550243, 2259.3222033389916, 2274.226762900605, 133677.0, 135550.0, 137060.0, 137377.3131134338, 138214.30892845674, 14777.556673299818, 15079.924600376928, 15092.471763488225, 15121.319540620698, 15397.692046159014, 23715.407114821923, 23719.0, 23804.166854160023, 23870.403239918793, 23873.970712489634, 9816.0, 9883.802323953625, 9966.451845148586, 10104.898951010542, 10193.0, 9096.408733432305, 9181.081891810765, 9232.53837308132, 9343.439393636403, 9344.065593440602, 7971.561564113914, 9021.594028268744, 9209.585568649427, 9268.119528644767, 9364.438133711863, 2525.431777849969, 2594.0, 2665.1338315047688, 2667.1198504493473, 2784.276088217038, 950.538988590533, 968.4915419404869, 985.6057576969126, 988.6243227573619, 989.2877128467636, 19386.385522330696, 19775.901120494305, 20128.798712012693, 20486.692699609517, 20732.06705698217, 1040.1990467340106, 1042.801867645145, 1048.4652827058103, 1049.0715716590719, 1054.2567489919588, 11007.889921100686, 13532.391042402918, 14132.434702611987, 14198.29008549589, 14355.210463424612, 492527.0, 493619.0, 508971.0, 511990.0, 515338.0, 111018.44490777495, 121150.0, 122009.38995304967, 122867.0, 123219.38390307991, 1238.8141778733261, 1246.077902352271, 1266.0125102420127, 1268.131330038908, 1291.3156027305356, 21485.248016319354, 21536.138554457648, 21544.569108617427, 21628.567428651655, 21706.782932170478, 54430.183547247616, 55500.0, 56349.0, 56785.0, 57764.0, 69743.65128174327, 70129.0, 70206.64896675484, 70492.0, 70691.29308706846, 12684.302363370103, 13212.603621891358, 14208.502702405367, 14629.70740585161, 14690.485832995793, 23298.184563540195, 24280.271591852274, 24506.754932450447, 24517.877410613546, 24588.50822983566, 18730.625387491902, 18863.90568047151, 19108.808911910703, 19196.616067678846, 19211.135498902862, 17288.65422691514, 17306.653866922843, 17640.29438822484, 17759.911200443916, 18112.366067187584, 18097.457076287734, 18234.544136396697, 18435.446936591925, 18689.813101868807, 18721.689481736146, 14645.92677036608, 14653.92673036628, 14667.48663796762, 14668.853311466748, 14694.779578306549, 18015.72976405329, 18386.908065459585, 18444.446666599488, 18462.723059154392, 18474.722879157092], "value": 12081.210424068566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.4045020191115, 1410.0341266232624, 1421.950231741889, 1423.0536693099089, 1427.750143724848, 13723.451061957523, 13902.721945561083, 14279.428822847087, 14303.642408939782, 14304.427822887084, 14927.253637318145, 15193.77209341858, 15200.16399098049, 15209.23953802311, 15213.77179342308, 2648.5497465430876, 2708.079253053961, 2709.498742732601, 2721.4421043686098, 2724.141895302983, 2716.904908328209, 2842.502562051643, 2842.673092594347, 2843.4597426489004, 2844.345800465894, 2711.200195942202, 2749.670039595251, 2757.6690797104375, 2769.3492029373083, 2772.7365900239447, 2735.4665840161274, 2742.5749008903654, 2752.2018614601743, 2759.18604011817, 2761.765249953756, 2621.8033647476514, 2631.8551430127764, 2640.392709676785, 2640.6303117563557, 2652.151311580295, 14255.0, 14479.855201447956, 14514.274286285749, 14539.491117810825, 14576.489822856256, 7604.391648668094, 7909.090454597737, 7922.960385198037, 7933.523988560647, 7968.7609371718945, 5315.707636080014, 5381.784728610851, 5443.564514838803, 5517.034518959166, 5530.419305972895, 1855.7216417537477, 1858.433177880746, 1862.087577087231, 1865.7481240032694, 1890.962180756391, 24035.158769443162, 24206.7579324208, 24213.757862421327, 24302.39244018896, 24323.635145472832, 6512.739490420425, 6584.7366105356205, 6622.933770662232, 6740.629265390353, 6815.7614483493835, 16502.504924852274, 16505.587360316087, 16534.586635334213, 16549.25528351203, 16615.08617026075, 7718.96140519305, 7791.220877912277, 7863.37093032556, 7876.330511906437, 7885.1326354101, 5946.45096501177, 7244.384227340735, 7273.745418910418, 7306.232845551247, 7336.486445948733, 5057.645964782503, 5196.32447781786, 5268.81559145428, 5286.0, 5352.464753524617, 1410.9929450352683, 1430.81399418075, 1431.06980462698, 1462.0715845438224, 1463.1733070814955, 887.0641473245788, 907.1790030022839, 908.7864351877304, 915.7664795477244, 926.1803304075942, 7258.383037441771, 7317.963410183022, 7400.555966642019, 7428.591427471541, 7434.553926764412, 731.3344856180956, 740.2449501508431, 741.4661443760592, 741.5587725303436, 746.3767753925533, 5573.865452221164, 5761.740721667535, 5838.620489668158, 5894.32215295238, 5974.133750606225, 20327.8983605084, 20730.89634551848, 20790.1683932641, 20832.895835521027, 21121.89439052795, 19259.807401926082, 20463.28378506745, 20641.89679051625, 20645.380638580868, 20656.277030303867, 11043.723906902393, 11293.604723834625, 11297.943510282395, 11308.378039207922, 11325.093992480583, 8395.454295470774, 8787.384883058381, 8789.692360767342, 8793.956030219808, 9188.540572971458, 17262.0, 17332.0, 17333.826661733725, 17611.911940440215, 17870.91064544669, 17832.643347132725, 17860.285588576313, 17906.5523361917, 18151.364702235358, 18392.632147357246, 12151.270923744603, 12582.24506529611, 12738.554150604685, 13124.671883202996, 13134.868651313365, 13683.589492315246, 14056.929715351358, 14082.295885205904, 14098.083624564371, 14102.929485352917, 11028.503717332578, 11160.218784684994, 11256.774864502828, 11262.83105753398, 11409.201355905006, 10402.791944161227, 10560.471976401303, 10562.89437105619, 10718.946405268236, 10875.347479151276, 9564.61741530331, 9768.706938791847, 9779.559919803769, 9791.118799308097, 9800.607975680892, 7380.188179300165, 7421.666025028994, 7433.2195119513835, 7442.702291908479, 7479.775606731807, 7361.153467351323, 7372.63136843145, 7407.666655000646, 7409.259074092548, 7484.176740558425], "value": 6557.746347689658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.36219509150385, 506.6200349737697, 518.7950759450017, 528.8915772266686, 535.973201339933, 6207.782727604535, 6254.468370188533, 6308.810735677931, 6321.209848768904, 6321.577645029872, 6086.747903275783, 6089.421504957033, 6120.846978825532, 6165.475934545558, 6205.937940620593, 5081.263216833566, 5095.8216462423825, 5142.922856157161, 5170.327857378536, 5175.689458632475, 4965.826196083138, 5036.169032109698, 5116.795328186887, 5125.794968201268, 5166.881578552794, 5165.870853228681, 5206.0, 5207.953347291839, 5219.147202743028, 5254.21186821976, 5114.514121158521, 5180.378354597435, 5186.273921650972, 5203.7398130093725, 5211.530962213419, 4799.832005879813, 4832.178529649968, 4854.514548545152, 4867.732274724889, 4869.732164730938, 6119.847003824895, 6148.6618235997, 6150.261968563756, 6181.3818618138275, 6231.470325022333, 5982.8504287392725, 6023.247094113236, 6036.788712395045, 6046.455818976269, 6047.134279748637, 6584.407403333675, 6615.37153970372, 6646.435053020499, 6687.197536295627, 6749.628770417625, 5242.169228616543, 5290.55030322423, 5301.363836339626, 5313.734313284321, 5332.466753324676, 6636.767713130017, 6745.224299205605, 6821.192384018239, 6973.965130174418, 6991.685374158124, 5447.346318441812, 5459.945400546023, 5492.780288788484, 5513.5037846594, 5513.751881165357, 5515.227868098389, 5518.255035570227, 5561.860953476114, 5567.498925096761, 5617.297837770278, 5911.231539899872, 5999.580029397987, 6008.798240351947, 6022.5483088768515, 6039.7282122304605, 6577.572457790324, 6621.271660117383, 6635.5023373247195, 6690.454059348553, 6699.387238976803, 1934.429343343717, 1938.903054847252, 1956.227290220355, 1977.5155087003777, 1977.604479104185, 1404.2978510744629, 1445.8481859404822, 1449.4854326713864, 1457.6938842843122, 1457.6938842843122, 5733.397993210653, 5751.626144300607, 5816.680082595413, 5821.18503409523, 5843.18195452637, 6680.83297917556, 6732.831679207961, 6745.0556922030955, 6768.221654509696, 6791.626460544619, 5742.019003443888, 5759.280089988752, 5771.624844385102, 5840.510669779179, 5845.1232315153065, 3536.398812201932, 3602.9731526514815, 3620.4569314602495, 3639.6178401268016, 3669.743117981769, 6492.740290388331, 6527.510436717265, 6610.207599490331, 6623.3376662333385, 6623.34416395901, 6905.965470172718, 6959.756408525677, 6961.477889158232, 7001.159860816734, 7010.0021493874, 6487.740490380332, 6542.705578249085, 6543.672816359068, 6565.967170164214, 6592.670366481752, 6676.599404035774, 6731.932680673131, 6747.932520674927, 6844.418224450778, 6851.3491218334175, 6647.476837276251, 6680.565763225375, 6699.789069607115, 6705.497087718343, 6713.690830288242, 6530.314316996837, 6535.901961470487, 6563.9343606563325, 6588.550518886029, 6650.767223147167, 5528.834134975797, 5553.555715542666, 5568.610197286151, 5568.805091821767, 5573.749181286771, 6543.738250469928, 6593.307702691341, 6741.157355330583, 6843.828904277433, 6869.656517174221, 6488.188976377953, 6581.3418658133805, 6587.571807832475, 6613.966930165318, 6665.0, 6506.967465162644, 6531.771388001397, 6572.338203027782, 6628.701708423229, 6647.833804154935, 6296.905546416899, 6353.680906469198, 6428.871422571616, 6509.381608747161, 6532.118164047793, 6551.246606640298, 6567.089619342439, 6590.5716128451495, 6609.537332386687, 6691.728571571581, 6395.808125756234, 6399.200099987502, 6423.96788016057, 6426.710798014007, 6430.421262086435], "value": 5216.3314988550355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.4000819450968, 915.2906497464464, 929.4934260827848, 937.6390089815424, 937.8640097185909, 18424.447266582007, 19068.904655476705, 19121.0, 19138.61722765547, 19212.903935480303, 17438.389656361996, 18355.908220458914, 21945.890270548665, 21981.890090549565, 22144.0, 1061.8247989081792, 1074.6990842564055, 1075.8171110911164, 1077.0414331245197, 1079.3416016230094, 983.3165949664985, 1050.8266136087536, 1054.19880890523, 1054.4991129213602, 1060.8620879285681, 1104.282216559235, 1114.7213196700825, 1118.8657361116677, 1119.7088756923176, 1120.6525976947173, 1116.3246236027207, 1119.2724728926182, 1119.5242022140558, 1119.9216054876163, 1119.9720006999848, 821.4414198345123, 822.786075620343, 822.9835403291961, 823.0904850140628, 824.8680211166245, 19188.0, 19318.517037074045, 19351.12919918607, 19420.4173874784, 20093.598128037505, 20739.27412540554, 21390.14439422421, 21928.89035554828, 22419.775802241933, 22448.775512244832, 15837.92081039599, 15947.840521594751, 16035.679286414323, 16094.436694715629, 16228.837711622851, 3673.3938900081453, 3695.6489133532273, 3696.2237930034726, 3696.611855755134, 3696.8706095286534, 129243.0, 130137.0, 130905.34547327297, 133133.0, 133334.3333283337, 16586.336546538005, 17207.913960430116, 17297.56756081108, 17315.393961211295, 17385.47843564695, 32040.0, 32118.518222226685, 32723.83638081842, 32743.345133097682, 32836.67163328384, 8674.696385626472, 8763.91236087631, 8942.418742781698, 8976.551172441483, 9008.954955225314, 4237.300845360543, 4304.612584867377, 4316.309390497506, 4350.564943505624, 4353.6299414549485, 5179.98990196908, 5182.507661772125, 5246.711430871339, 5251.317328747238, 5296.549793267615, 1112.777444511085, 1120.4117838135044, 1124.983125253122, 1125.836753670713, 1128.9604863829727, 696.5333226738097, 700.7092056796372, 712.3197346534048, 717.4475653746586, 723.1250187273353, 11548.711282218012, 11733.823992640117, 11945.88054119465, 12028.218165819193, 12565.560205392767, 632.3265722006049, 643.2217017408988, 675.6824292582478, 697.2574208468067, 731.4843035659848, 5197.948020519822, 5391.56867450603, 5478.58910581708, 5522.392536820947, 5575.665460072409, 108274.45862770636, 110873.89126108636, 111487.44256278829, 111786.0, 113641.43179284217, 73476.63261683658, 95201.52399238099, 96651.0, 97963.51018245006, 104783.0, 79312.60343698245, 84756.57621711976, 85907.57046214853, 88027.0, 91093.0, 12377.690557736129, 12397.380130993595, 12834.358282086045, 12846.0, 13097.869021309665, 39317.41023884701, 40352.596474034886, 40472.0, 41259.587404125574, 42217.36673949832, 67125.0, 67612.32387676061, 69576.0, 70923.0, 74792.62603686946, 19269.22923083061, 19417.223311067963, 19516.121774520463, 19548.511287217934, 19863.0, 19834.0, 20021.899890500456, 20198.495037624176, 20389.286374976804, 20437.284695035603, 17945.551361216076, 18161.182746776693, 18175.18211680504, 18181.54546136357, 18256.36102736398, 18022.0, 18048.639027219644, 18090.819091808913, 18099.09504524742, 18338.174782135102, 17474.82525174732, 17529.1235438225, 17578.73631895497, 17592.824071759118, 17693.469195924143, 13759.656008599864, 14022.22877741734, 14190.716185676021, 14207.289635517976, 14314.928425357806, 14613.253209831422, 14665.48670796517, 14691.0, 14807.25963701789, 14883.776743348642], "value": 9327.452369421693, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 99.0, 107.0, 113.0, 115.0, 109.0, 100.0, 108.0, 107.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 149.0, 174.0, 117.0, 146.0, 156.0, 120.0, 167.0, 117.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 161.0, 165.0, 164.0, 164.0, 162.0, 174.0, 165.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 76.0, 172.0, 75.0, 74.0, 74.0, 81.0, 97.0, 77.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 139.0, 80.0, 79.0, 78.0, 131.0, 79.0, 79.0, 134.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 119.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 155.0, 150.0, 150.0, 150.0, 153.0, 153.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 99.0, 99.0, 98.0, 99.0, 94.0, 98.0, 94.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 57.0, 62.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 54.0, 56.0, 55.0, 55.0, 53.0, 54.0, 54.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 79.0, 76.0, 75.0, 75.0, 80.0, 78.0, 75.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 121.0, 133.0, 123.0, 120.0, 120.0, 127.0, 125.0, 153.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 174.0, 172.0, 176.0, 178.0, 169.0, 172.0, 169.0, 175.0, 171.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 67.0, 71.0, 70.0, 67.0, 68.0, 67.0, 73.0], "value": 69.2, "unit": "score"}]}]} 11:21:03 INFO - Return code: 0 11:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:21:03 INFO - # TBPL SUCCESS # 11:21:03 INFO - Running post-action listener: _package_coverage_data 11:21:03 INFO - Running post-action listener: _resource_record_post_action 11:21:03 INFO - [mozharness: 2017-08-20 18:21:03.315997Z] Finished run-tests step (success) 11:21:03 INFO - Running post-run listener: _resource_record_post_run 11:21:03 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 436363264; Read time: 508; Write time: 305092 11:21:03 INFO - TinderboxPrint: CPU usage
13.2% 11:21:03 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 508 11:21:03 INFO - TinderboxPrint: I/O write bytes / time
436,363,264 / 305,092 11:21:03 INFO - TinderboxPrint: CPU idle
8,256.0 (86.8%) 11:21:03 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 11:21:03 INFO - TinderboxPrint: Swap in / out
0 / 0 11:21:03 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111452160; Read time: 264; Write time: 83416 11:21:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:21:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324911104; Read time: 236; Write time: 221676 11:21:03 INFO - Running post-run listener: _upload_blobber_files 11:21:03 INFO - Blob upload gear active. 11:21:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:21:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:21:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:11 INFO - (blobuploader) - INFO - Done attempting. 11:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:11 INFO - (blobuploader) - INFO - Done attempting. 11:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:12 INFO - (blobuploader) - INFO - Done attempting. 11:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:13 INFO - (blobuploader) - INFO - Done attempting. 11:21:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:13 INFO - Return code: 0 11:21:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:21:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1260b4aec82799fc32562cfe8cdbb18b2f93599864ab95be1ed382fb64f20a7d52386563ffbdfe2f49648a3c0984223cff36a43153239db6216f1cec371dc604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc9874aa3d4be9a8b034938f89d7daf8652331c7d95fb520764b4592ebc3ab6a3973b57d1356cc127bd940cd56d9300df689e9faaad3b02a00019fcf5985bc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792def530305c9153b6a1e2d0e7486af52003252014e99eb131f3b44f97d929d439c145123cd90de0cc41e91ca1b92ecc456868c8a400ff004f197c6639133e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c465e32f2fd8a991c0b1bd86f25a7c9962070d87041a8b72db4669b8188401e7fe89fc40018581d7a6f7e585e88397f26253391d24fda8d6d9f8ca138a6e7d0d"} 11:21:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:21:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:21:13 INFO - Contents: 11:21:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1260b4aec82799fc32562cfe8cdbb18b2f93599864ab95be1ed382fb64f20a7d52386563ffbdfe2f49648a3c0984223cff36a43153239db6216f1cec371dc604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc9874aa3d4be9a8b034938f89d7daf8652331c7d95fb520764b4592ebc3ab6a3973b57d1356cc127bd940cd56d9300df689e9faaad3b02a00019fcf5985bc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792def530305c9153b6a1e2d0e7486af52003252014e99eb131f3b44f97d929d439c145123cd90de0cc41e91ca1b92ecc456868c8a400ff004f197c6639133e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c465e32f2fd8a991c0b1bd86f25a7c9962070d87041a8b72db4669b8188401e7fe89fc40018581d7a6f7e585e88397f26253391d24fda8d6d9f8ca138a6e7d0d"} 11:21:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:13 INFO - Copying logs to upload dir... 11:21:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:21:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.586690 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-08-20 11:21:12.441100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 11:21:12.445726) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1260b4aec82799fc32562cfe8cdbb18b2f93599864ab95be1ed382fb64f20a7d52386563ffbdfe2f49648a3c0984223cff36a43153239db6216f1cec371dc604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc9874aa3d4be9a8b034938f89d7daf8652331c7d95fb520764b4592ebc3ab6a3973b57d1356cc127bd940cd56d9300df689e9faaad3b02a00019fcf5985bc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792def530305c9153b6a1e2d0e7486af52003252014e99eb131f3b44f97d929d439c145123cd90de0cc41e91ca1b92ecc456868c8a400ff004f197c6639133e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c465e32f2fd8a991c0b1bd86f25a7c9962070d87041a8b72db4669b8188401e7fe89fc40018581d7a6f7e585e88397f26253391d24fda8d6d9f8ca138a6e7d0d"} build_url:https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011698 build_url: 'https://queue.taskcluster.net/v1/task/LJxQRdN-QvOV7_FMIYAiQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1260b4aec82799fc32562cfe8cdbb18b2f93599864ab95be1ed382fb64f20a7d52386563ffbdfe2f49648a3c0984223cff36a43153239db6216f1cec371dc604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc9874aa3d4be9a8b034938f89d7daf8652331c7d95fb520764b4592ebc3ab6a3973b57d1356cc127bd940cd56d9300df689e9faaad3b02a00019fcf5985bc1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792def530305c9153b6a1e2d0e7486af52003252014e99eb131f3b44f97d929d439c145123cd90de0cc41e91ca1b92ecc456868c8a400ff004f197c6639133e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c465e32f2fd8a991c0b1bd86f25a7c9962070d87041a8b72db4669b8188401e7fe89fc40018581d7a6f7e585e88397f26253391d24fda8d6d9f8ca138a6e7d0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 11:21:12.475299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:21:12.475615) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503251720.509577-610435171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:21:12.556197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 11:21:12.559538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 11:21:12.559835) ========= ========= Total master_lag: 0.23 =========