builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1506163034.23 results: success (0) revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.235260) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.235778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.236060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.248507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.248885) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 03:37:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-09-23 03:37:14 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.374406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.374843) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.424899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:14.427250) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e --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 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e --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=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 03:37:14,472 truncating revision to first 12 chars 2017-09-23 03:37:14,472 Setting DEBUG logging. 2017-09-23 03:37:14,472 attempt 1/10 2017-09-23 03:37:14,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8db0c4ecd94c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 03:37:15,046 unpacking tar archive at: mozilla-central-8db0c4ecd94c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:15.339834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:15.340142) ========= script_repo_revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:15.340512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:15.340769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:37:15.357880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-23 03:37:15.358298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:15 INFO - MultiFileLogger online at 20170923 03:37:15 in /builds/slave/test 03:37:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:37:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:15 INFO - {'append_to_log': False, 03:37:15 INFO - 'base_work_dir': '/builds/slave/test', 03:37:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:37:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:15 INFO - 'branch': 'Firefox-Non-PGO', 03:37:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:15 INFO - 'code_coverage': False, 03:37:15 INFO - 'config_files': ('talos/linux_config.py',), 03:37:15 INFO - 'default_actions': ('clobber', 03:37:15 INFO - 'read-buildbot-config', 03:37:15 INFO - 'download-and-extract', 03:37:15 INFO - 'populate-webroot', 03:37:15 INFO - 'create-virtualenv', 03:37:15 INFO - 'install', 03:37:15 INFO - 'setup-mitmproxy', 03:37:15 INFO - 'run-tests'), 03:37:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:15 INFO - 'disable_ccov_upload': False, 03:37:15 INFO - 'disable_stylo': False, 03:37:15 INFO - 'download_minidump_stackwalk': True, 03:37:15 INFO - 'download_symbols': 'ondemand', 03:37:15 INFO - 'enable_stylo': False, 03:37:15 INFO - 'enable_webrender': False, 03:37:15 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:37:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:15 INFO - 'gecko_profile': False, 03:37:15 INFO - 'gecko_profile_interval': 0, 03:37:15 INFO - 'installer_path': 'installer.exe', 03:37:15 INFO - 'log_level': 'info', 03:37:15 INFO - 'log_name': 'talos', 03:37:15 INFO - 'log_to_console': True, 03:37:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:15 INFO - 'opt_config_files': (), 03:37:15 INFO - 'pip_index': False, 03:37:15 INFO - 'suite': 'dromaeojs-e10s', 03:37:15 INFO - 'system_bits': '32', 03:37:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:15 INFO - 'title': 'talos-linux64-ix-088', 03:37:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:15 INFO - 'use_talos_json': True, 03:37:15 INFO - 'verify': 'False', 03:37:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:15 INFO - 'work_dir': 'build'} 03:37:15 INFO - [mozharness: 2017-09-23 10:37:15.551468Z] Running clobber step. 03:37:15 INFO - Running pre-action listener: _resource_record_pre_action 03:37:15 INFO - Running main action method: clobber 03:37:15 INFO - rmtree: /builds/slave/test/build 03:37:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:16 INFO - Running post-action listener: _resource_record_post_action 03:37:16 INFO - [mozharness: 2017-09-23 10:37:16.604222Z] Finished clobber step (success) 03:37:16 INFO - [mozharness: 2017-09-23 10:37:16.604322Z] Running read-buildbot-config step. 03:37:16 INFO - Running pre-action listener: _resource_record_pre_action 03:37:16 INFO - Running main action method: read_buildbot_config 03:37:16 INFO - Using buildbot properties: 03:37:16 INFO - { 03:37:16 INFO - "project": "", 03:37:16 INFO - "product": "firefox", 03:37:16 INFO - "who": "archaeopteryx@coole-files.de", 03:37:16 INFO - "installer_path": "public/build/target.tar.bz2", 03:37:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:37:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:37:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:37:16 INFO - "stage_platform": "linux64", 03:37:16 INFO - "basedir": "/builds/slave/test", 03:37:16 INFO - "buildnumber": 857, 03:37:16 INFO - "platform": "ubuntu64_hw", 03:37:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:37:16 INFO - "slavebuilddir": "test", 03:37:16 INFO - "taskId": "CBjF-bq3QXugAfn12PjDnQ", 03:37:16 INFO - "branch": "mozilla-central", 03:37:16 INFO - "script_repo_revision": "production", 03:37:16 INFO - "revision": "8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e", 03:37:16 INFO - "slavename": "talos-linux64-ix-088", 03:37:16 INFO - "repo_path": "mozilla-central" 03:37:16 INFO - } 03:37:16 INFO - Finding installer, test and symbols from parent task. 03:37:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBjF-bq3QXugAfn12PjDnQ'}, attempt #1 03:37:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBjF-bq3QXugAfn12PjDnQ'}, attempt #1 03:37:17 INFO - Task dependencies: G4ULSq9NTWSDYYmNphUW3A 03:37:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A'}, attempt #1 03:37:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:37:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:37:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip 03:37:17 INFO - Running post-action listener: _resource_record_post_action 03:37:17 INFO - [mozharness: 2017-09-23 10:37:17.976605Z] Finished read-buildbot-config step (success) 03:37:17 INFO - [mozharness: 2017-09-23 10:37:17.976829Z] Running download-and-extract step. 03:37:17 INFO - Running pre-action listener: _resource_record_pre_action 03:37:17 INFO - Running main action method: download_and_extract 03:37:17 INFO - mkdir: /builds/slave/test/build/tests 03:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:17 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:37:17 INFO - Downloading https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:37:19 INFO - Downloaded 989 bytes. 03:37:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:37:19 INFO - Using the following test package requirements: 03:37:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:37:19 INFO - u'common': [u'target.common.tests.zip'], 03:37:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:37:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:37:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:37:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:37:19 INFO - u'mozbase': [u'target.common.tests.zip'], 03:37:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:37:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:37:19 INFO - u'web-platform': [u'target.common.tests.zip', 03:37:19 INFO - u'target.web-platform.tests.tar.gz'], 03:37:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:37:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:37:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip 03:37:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:37:19 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip into memory 03:37:21 INFO - Content-Length response header: 54943895 03:37:21 INFO - Bytes received: 54943895 03:37:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip 03:37:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:37:32 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip into memory 03:37:33 INFO - Content-Length response header: 14513823 03:37:33 INFO - Bytes received: 14513823 03:37:34 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')]} 03:37:34 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:37:34 INFO - Downloading https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:37:36 INFO - Downloaded 61675129 bytes. 03:37:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:37:36 INFO - mkdir: /builds/slave/test/properties 03:37:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:36 INFO - Contents: 03:37:36 INFO - build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:37:36 INFO - Running post-action listener: _resource_record_post_action 03:37:36 INFO - Running post-action listener: find_tests_for_verification 03:37:36 INFO - Running post-action listener: set_extra_try_arguments 03:37:36 INFO - [mozharness: 2017-09-23 10:37:36.442149Z] Finished download-and-extract step (success) 03:37:36 INFO - [mozharness: 2017-09-23 10:37:36.442248Z] Running populate-webroot step. 03:37:36 INFO - Running pre-action listener: _resource_record_pre_action 03:37:36 INFO - Running main action method: populate_webroot 03:37:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['tresize', 03:37:36 INFO - 'tcanvasmark']}, 03:37:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['dromaeo_css', 03:37:36 INFO - 'kraken']}, 03:37:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'tests': ['damp', 'tps']}, 03:37:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['damp', 'tps']}, 03:37:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['dromaeo_dom']}, 03:37:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:37:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['basic_compositor_video', 03:37:36 INFO - 'glvideo']}, 03:37:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:37:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['ts_paint_webext', 03:37:36 INFO - 'tp5o_webext']}, 03:37:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:36 INFO - 'ts_paint', 03:37:36 INFO - 'tpaint', 03:37:36 INFO - 'sessionrestore', 03:37:36 INFO - 'sessionrestore_many_windows', 03:37:36 INFO - 'sessionrestore_no_auto_restore', 03:37:36 INFO - 'tabpaint']}, 03:37:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['a11yr', 03:37:36 INFO - 'ts_paint', 03:37:36 INFO - 'tpaint', 03:37:36 INFO - 'sessionrestore', 03:37:36 INFO - 'sessionrestore_many_windows', 03:37:36 INFO - 'sessionrestore_no_auto_restore', 03:37:36 INFO - 'tabpaint']}, 03:37:36 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:37:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:37:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['perf_reftest_singletons']}, 03:37:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['perf_reftest']}, 03:37:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:36 INFO - 'tsvgr_opacity', 03:37:36 INFO - 'tart', 03:37:36 INFO - 'tscrollx', 03:37:36 INFO - 'tsvg_static']}, 03:37:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['tsvgx', 03:37:36 INFO - 'tsvgr_opacity', 03:37:36 INFO - 'tart', 03:37:36 INFO - 'tscrollx', 03:37:36 INFO - 'tsvg_static']}, 03:37:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:37:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--disable-stylo'], 03:37:36 INFO - 'tests': ['tp5o']}, 03:37:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:37:36 INFO - 'talos_options': ['--mitmproxy', 03:37:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:36 INFO - '--firstNonBlankPaint'], 03:37:36 INFO - 'tests': ['tp6_google', 03:37:36 INFO - 'tp6_youtube', 03:37:36 INFO - 'tp6_amazon', 03:37:36 INFO - 'tp6_facebook']}, 03:37:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:37:36 INFO - 'talos_options': ['--disable-stylo', 03:37:36 INFO - '--mitmproxy', 03:37:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:36 INFO - '--firstNonBlankPaint'], 03:37:36 INFO - 'tests': ['tp6_google', 03:37:36 INFO - 'tp6_youtube', 03:37:36 INFO - 'tp6_amazon', 03:37:36 INFO - 'tp6_facebook']}, 03:37:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:37:36 INFO - 'talos_options': ['--stylo-threads=1', 03:37:36 INFO - '--mitmproxy', 03:37:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:36 INFO - '--firstNonBlankPaint'], 03:37:36 INFO - 'tests': ['tp6_google', 03:37:36 INFO - 'tp6_youtube', 03:37:36 INFO - 'tp6_amazon', 03:37:36 INFO - 'tp6_facebook']}, 03:37:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--xperf_path', 03:37:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:36 INFO - 'tests': ['tp5n']}, 03:37:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:37:36 INFO - 'talos_options': ['--disable-stylo', 03:37:36 INFO - '--xperf_path', 03:37:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:36 INFO - 'tests': ['tp5n']}}} 03:37:36 INFO - Running post-action listener: _resource_record_post_action 03:37:36 INFO - [mozharness: 2017-09-23 10:37:36.457723Z] Finished populate-webroot step (success) 03:37:36 INFO - [mozharness: 2017-09-23 10:37:36.457814Z] Running create-virtualenv step. 03:37:36 INFO - Running pre-action listener: _resource_record_pre_action 03:37:36 INFO - Running main action method: create_virtualenv 03:37:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:37:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:37:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:37:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:37 INFO - Installing pip...............done. 03:37:37 INFO - Return code: 0 03:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:37:37 INFO - Reading from file tmpfile_stdout 03:37:37 INFO - Output received: 03:37:37 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:37:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:37 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')]} 03:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:37 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')]} 03:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:37 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:37 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 03:37:37 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 03:37:37 INFO - Using env: {'DISPLAY': ':0', 03:37:37 INFO - 'HOME': '/home/cltbld', 03:37:37 INFO - 'LANG': 'en_US.UTF-8', 03:37:37 INFO - 'LANGUAGE': 'en_US:en', 03:37:37 INFO - 'LOGNAME': 'cltbld', 03:37:37 INFO - 'MAIL': '/var/mail/cltbld', 03:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:37 INFO - 'MOZ_NO_REMOTE': '1', 03:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:37 INFO - 'NO_EM_RESTART': '1', 03:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:37 INFO - 'PWD': '/builds/slave/test', 03:37:37 INFO - 'SHELL': '/bin/bash', 03:37:37 INFO - 'SHLVL': '1', 03:37:37 INFO - 'TERM': 'linux', 03:37:37 INFO - 'TMOUT': '86400', 03:37:37 INFO - 'USER': 'cltbld', 03:37:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:37 INFO - '_': '/tools/buildbot/bin/python'} 03:37:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:37:38 INFO - Downloading/unpacking pip>=1.5 03:37:38 INFO - Running setup.py egg_info for package pip 03:37:38 INFO - warning: no files found matching 'pip/cacert.pem' 03:37:38 INFO - warning: no files found matching '*.html' under directory 'docs' 03:37:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:37:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:37:38 INFO - Installing collected packages: pip 03:37:38 INFO - Found existing installation: pip 1.1 03:37:38 INFO - Uninstalling pip: 03:37:38 INFO - Successfully uninstalled pip 03:37:38 INFO - Running setup.py install for pip 03:37:38 INFO - warning: no files found matching 'pip/cacert.pem' 03:37:38 INFO - warning: no files found matching '*.html' under directory 'docs' 03:37:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:37:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:37:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Successfully installed pip 03:37:38 INFO - Cleaning up... 03:37:38 INFO - Return code: 0 03:37:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:37:38 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')]} 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:38 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')]} 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:38 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:38 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 03:37:38 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 03:37:38 INFO - Using env: {'DISPLAY': ':0', 03:37:38 INFO - 'HOME': '/home/cltbld', 03:37:38 INFO - 'LANG': 'en_US.UTF-8', 03:37:38 INFO - 'LANGUAGE': 'en_US:en', 03:37:38 INFO - 'LOGNAME': 'cltbld', 03:37:38 INFO - 'MAIL': '/var/mail/cltbld', 03:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:38 INFO - 'MOZ_NO_REMOTE': '1', 03:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:38 INFO - 'NO_EM_RESTART': '1', 03:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:38 INFO - 'PWD': '/builds/slave/test', 03:37:38 INFO - 'SHELL': '/bin/bash', 03:37:38 INFO - 'SHLVL': '1', 03:37:38 INFO - 'TERM': 'linux', 03:37:38 INFO - 'TMOUT': '86400', 03:37:38 INFO - 'USER': 'cltbld', 03:37:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:38 INFO - '_': '/tools/buildbot/bin/python'} 03:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:39 INFO - Downloading/unpacking psutil>=3.1.1 03:37:39 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 03:37:39 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 03:37:39 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 03:37:39 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 03:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:40 INFO - Installing collected packages: psutil 03:37:40 INFO - Running setup.py install for psutil 03:37:40 INFO - building 'psutil._psutil_linux' extension 03:37:40 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 03:37:40 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 03:37:40 INFO - building 'psutil._psutil_posix' extension 03:37:40 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 03:37:40 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 03:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:40 INFO - Successfully installed psutil 03:37:40 INFO - Cleaning up... 03:37:40 INFO - Return code: 0 03:37:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:37:40 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')]} 03:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:40 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')]} 03:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:40 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:40 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 03:37:40 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 03:37:40 INFO - Using env: {'DISPLAY': ':0', 03:37:40 INFO - 'HOME': '/home/cltbld', 03:37:40 INFO - 'LANG': 'en_US.UTF-8', 03:37:40 INFO - 'LANGUAGE': 'en_US:en', 03:37:40 INFO - 'LOGNAME': 'cltbld', 03:37:40 INFO - 'MAIL': '/var/mail/cltbld', 03:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:40 INFO - 'MOZ_NO_REMOTE': '1', 03:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:40 INFO - 'NO_EM_RESTART': '1', 03:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:40 INFO - 'PWD': '/builds/slave/test', 03:37:40 INFO - 'SHELL': '/bin/bash', 03:37:40 INFO - 'SHLVL': '1', 03:37:40 INFO - 'TERM': 'linux', 03:37:40 INFO - 'TMOUT': '86400', 03:37:40 INFO - 'USER': 'cltbld', 03:37:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:40 INFO - '_': '/tools/buildbot/bin/python'} 03:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:42 INFO - Installing collected packages: mozsystemmonitor 03:37:42 INFO - Running setup.py install for mozsystemmonitor 03:37:42 INFO - Successfully installed mozsystemmonitor 03:37:42 INFO - Cleaning up... 03:37:42 INFO - Return code: 0 03:37:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:42 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')]} 03:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:42 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')]} 03:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:42 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:42 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 03:37:42 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 03:37:42 INFO - Using env: {'DISPLAY': ':0', 03:37:42 INFO - 'HOME': '/home/cltbld', 03:37:42 INFO - 'LANG': 'en_US.UTF-8', 03:37:42 INFO - 'LANGUAGE': 'en_US:en', 03:37:42 INFO - 'LOGNAME': 'cltbld', 03:37:42 INFO - 'MAIL': '/var/mail/cltbld', 03:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:42 INFO - 'MOZ_NO_REMOTE': '1', 03:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:42 INFO - 'NO_EM_RESTART': '1', 03:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:42 INFO - 'PWD': '/builds/slave/test', 03:37:42 INFO - 'SHELL': '/bin/bash', 03:37:42 INFO - 'SHLVL': '1', 03:37:42 INFO - 'TERM': 'linux', 03:37:42 INFO - 'TMOUT': '86400', 03:37:42 INFO - 'USER': 'cltbld', 03:37:42 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:42 INFO - '_': '/tools/buildbot/bin/python'} 03:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:43 INFO - Downloading/unpacking jsonschema==2.5.1 03:37:43 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 03:37:43 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 03:37:43 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 03:37:43 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 03:37:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:44 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 03:37:44 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 03:37:44 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 03:37:44 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 03:37:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:44 INFO - warning: no files found matching '*.txt' 03:37:44 INFO - no previously-included directories found matching 'build' 03:37:44 INFO - no previously-included directories found matching 'dist' 03:37:44 INFO - no previously-included directories found matching '.git*' 03:37:44 INFO - Installing collected packages: jsonschema, functools32 03:37:44 INFO - Running setup.py install for functools32 03:37:44 INFO - warning: no files found matching '*.txt' 03:37:44 INFO - no previously-included directories found matching 'build' 03:37:44 INFO - no previously-included directories found matching 'dist' 03:37:44 INFO - no previously-included directories found matching '.git*' 03:37:44 INFO - Successfully installed jsonschema functools32 03:37:44 INFO - Cleaning up... 03:37:45 INFO - Return code: 0 03:37:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:45 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:45 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 03:37:45 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 03:37:45 INFO - Using env: {'DISPLAY': ':0', 03:37:45 INFO - 'HOME': '/home/cltbld', 03:37:45 INFO - 'LANG': 'en_US.UTF-8', 03:37:45 INFO - 'LANGUAGE': 'en_US:en', 03:37:45 INFO - 'LOGNAME': 'cltbld', 03:37:45 INFO - 'MAIL': '/var/mail/cltbld', 03:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:45 INFO - 'MOZ_NO_REMOTE': '1', 03:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:45 INFO - 'NO_EM_RESTART': '1', 03:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:45 INFO - 'PWD': '/builds/slave/test', 03:37:45 INFO - 'SHELL': '/bin/bash', 03:37:45 INFO - 'SHLVL': '1', 03:37:45 INFO - 'TERM': 'linux', 03:37:45 INFO - 'TMOUT': '86400', 03:37:45 INFO - 'USER': 'cltbld', 03:37:45 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:45 INFO - '_': '/tools/buildbot/bin/python'} 03:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:45 INFO - Cleaning up... 03:37:45 INFO - Return code: 0 03:37:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:45 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:45 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 03:37:45 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 03:37:45 INFO - Using env: {'DISPLAY': ':0', 03:37:45 INFO - 'HOME': '/home/cltbld', 03:37:45 INFO - 'LANG': 'en_US.UTF-8', 03:37:45 INFO - 'LANGUAGE': 'en_US:en', 03:37:45 INFO - 'LOGNAME': 'cltbld', 03:37:45 INFO - 'MAIL': '/var/mail/cltbld', 03:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:45 INFO - 'MOZ_NO_REMOTE': '1', 03:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:45 INFO - 'NO_EM_RESTART': '1', 03:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:45 INFO - 'PWD': '/builds/slave/test', 03:37:45 INFO - 'SHELL': '/bin/bash', 03:37:45 INFO - 'SHLVL': '1', 03:37:45 INFO - 'TERM': 'linux', 03:37:45 INFO - 'TMOUT': '86400', 03:37:45 INFO - 'USER': 'cltbld', 03:37:45 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:45 INFO - '_': '/tools/buildbot/bin/python'} 03:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:45 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 03:37:45 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 03:37:45 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 03:37:45 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 03:37:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:46 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 03:37:46 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 03:37:46 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 03:37:46 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 03:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:46 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 03:37:46 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 03:37:46 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 03:37:46 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 03:37:47 INFO - Downloading docopt-0.6.1.tar.gz 03:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:47 INFO - Running setup.py install for blobuploader 03:37:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:47 INFO - Running setup.py install for requests 03:37:47 INFO - Running setup.py install for docopt 03:37:47 INFO - Successfully installed blobuploader requests docopt 03:37:47 INFO - Cleaning up... 03:37:47 INFO - Return code: 0 03:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:47 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:47 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 03:37:47 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 03:37:47 INFO - Using env: {'DISPLAY': ':0', 03:37:47 INFO - 'HOME': '/home/cltbld', 03:37:47 INFO - 'LANG': 'en_US.UTF-8', 03:37:47 INFO - 'LANGUAGE': 'en_US:en', 03:37:47 INFO - 'LOGNAME': 'cltbld', 03:37:47 INFO - 'MAIL': '/var/mail/cltbld', 03:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:47 INFO - 'MOZ_NO_REMOTE': '1', 03:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:47 INFO - 'NO_EM_RESTART': '1', 03:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:47 INFO - 'PWD': '/builds/slave/test', 03:37:47 INFO - 'SHELL': '/bin/bash', 03:37:47 INFO - 'SHLVL': '1', 03:37:47 INFO - 'TERM': 'linux', 03:37:47 INFO - 'TMOUT': '86400', 03:37:47 INFO - 'USER': 'cltbld', 03:37:47 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:47 INFO - '_': '/tools/buildbot/bin/python'} 03:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:47 INFO - Running setup.py (path:/tmp/pip-SlaK3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:48 INFO - Running setup.py (path:/tmp/pip-akCb4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:48 INFO - Running setup.py (path:/tmp/pip-81d93e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:48 INFO - Running setup.py (path:/tmp/pip-YGvI5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:48 INFO - Running setup.py (path:/tmp/pip-hOjeNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:48 INFO - Running setup.py (path:/tmp/pip-jROwjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:48 INFO - Running setup.py (path:/tmp/pip-BeBdbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:48 INFO - Running setup.py (path:/tmp/pip-v2txIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:48 INFO - Running setup.py (path:/tmp/pip-AmdguR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:48 INFO - Running setup.py (path:/tmp/pip-LDcjDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:48 INFO - Running setup.py (path:/tmp/pip-nRsHlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:48 INFO - Running setup.py (path:/tmp/pip-WxMkqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:48 INFO - Running setup.py (path:/tmp/pip-ZainYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:48 INFO - Running setup.py (path:/tmp/pip-uQh55J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:48 INFO - Running setup.py (path:/tmp/pip-cLuMS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:49 INFO - Running setup.py (path:/tmp/pip-QZ0fo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:49 INFO - Running setup.py (path:/tmp/pip-p_72Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:49 INFO - Running setup.py install for manifestparser 03:37:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Running setup.py install for mozcrash 03:37:49 INFO - Running setup.py install for mozdebug 03:37:49 INFO - Running setup.py install for mozdevice 03:37:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Running setup.py install for mozfile 03:37:49 INFO - Running setup.py install for mozhttpd 03:37:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Running setup.py install for mozinfo 03:37:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Running setup.py install for mozInstall 03:37:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:49 INFO - Running setup.py install for mozleak 03:37:50 INFO - Running setup.py install for mozlog 03:37:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Running setup.py install for moznetwork 03:37:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Running setup.py install for mozprocess 03:37:50 INFO - Running setup.py install for mozprofile 03:37:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Running setup.py install for mozrunner 03:37:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Running setup.py install for mozscreenshot 03:37:50 INFO - Running setup.py install for moztest 03:37:50 INFO - Running setup.py install for mozversion 03:37:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:50 INFO - Cleaning up... 03:37:50 INFO - Return code: 0 03:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:50 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:50 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 03:37:50 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 03:37:50 INFO - Using env: {'DISPLAY': ':0', 03:37:50 INFO - 'HOME': '/home/cltbld', 03:37:50 INFO - 'LANG': 'en_US.UTF-8', 03:37:50 INFO - 'LANGUAGE': 'en_US:en', 03:37:50 INFO - 'LOGNAME': 'cltbld', 03:37:50 INFO - 'MAIL': '/var/mail/cltbld', 03:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:50 INFO - 'MOZ_NO_REMOTE': '1', 03:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:50 INFO - 'NO_EM_RESTART': '1', 03:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:50 INFO - 'PWD': '/builds/slave/test', 03:37:50 INFO - 'SHELL': '/bin/bash', 03:37:50 INFO - 'SHLVL': '1', 03:37:50 INFO - 'TERM': 'linux', 03:37:50 INFO - 'TMOUT': '86400', 03:37:50 INFO - 'USER': 'cltbld', 03:37:50 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:50 INFO - '_': '/tools/buildbot/bin/python'} 03:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:51 INFO - Running setup.py (path:/tmp/pip-SUg67F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:51 INFO - Running setup.py (path:/tmp/pip-uV86rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:51 INFO - Running setup.py (path:/tmp/pip-7Mem4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:51 INFO - Running setup.py (path:/tmp/pip-tlQqvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:51 INFO - Running setup.py (path:/tmp/pip-dg68Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:51 INFO - Running setup.py (path:/tmp/pip-EAWBcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:51 INFO - Running setup.py (path:/tmp/pip-utuHMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:51 INFO - Running setup.py (path:/tmp/pip-xp6FRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:51 INFO - Running setup.py (path:/tmp/pip-JY61zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:51 INFO - Running setup.py (path:/tmp/pip-XmPyQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:51 INFO - Running setup.py (path:/tmp/pip-Ik78iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:51 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)) 03:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:51 INFO - Running setup.py (path:/tmp/pip-Rizrid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:52 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)) 03:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:52 INFO - Running setup.py (path:/tmp/pip-x9dC42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:52 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)) 03:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:52 INFO - Running setup.py (path:/tmp/pip-DtBmuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:52 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)) 03:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:52 INFO - Running setup.py (path:/tmp/pip-z0U4VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:52 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)) 03:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:52 INFO - Running setup.py (path:/tmp/pip-nh2_zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:52 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)) 03:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:52 INFO - Running setup.py (path:/tmp/pip-rxBrJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:52 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)) 03:37:52 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)) 03:37:52 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)) 03:37:52 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)) 03:37:52 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)) 03:37:52 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)) 03:37:52 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)) 03:37:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:53 INFO - Downloading blessings-1.6.tar.gz 03:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:53 INFO - Installing collected packages: blessings 03:37:53 INFO - Running setup.py install for blessings 03:37:53 INFO - Successfully installed blessings 03:37:53 INFO - Cleaning up... 03:37:53 INFO - Return code: 0 03:37:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:53 INFO - Reading from file tmpfile_stdout 03:37:53 INFO - Current package versions: 03:37:53 INFO - argparse == 1.2.1 03:37:53 INFO - blessings == 1.6 03:37:53 INFO - blobuploader == 1.2.4 03:37:53 INFO - docopt == 0.6.1 03:37:53 INFO - functools32 == 3.2.3-2 03:37:53 INFO - jsonschema == 2.5.1 03:37:53 INFO - manifestparser == 1.1 03:37:53 INFO - mozInstall == 1.13 03:37:53 INFO - mozcrash == 1.0 03:37:53 INFO - mozdebug == 0.1 03:37:53 INFO - mozdevice == 0.51 03:37:53 INFO - mozfile == 1.2 03:37:53 INFO - mozhttpd == 0.7 03:37:53 INFO - mozinfo == 0.10 03:37:53 INFO - mozleak == 0.1 03:37:53 INFO - mozlog == 3.5 03:37:53 INFO - moznetwork == 0.27 03:37:53 INFO - mozprocess == 0.25 03:37:53 INFO - mozprofile == 0.28 03:37:53 INFO - mozrunner == 6.13 03:37:53 INFO - mozscreenshot == 0.1 03:37:53 INFO - mozsystemmonitor == 0.3 03:37:53 INFO - moztest == 0.8 03:37:53 INFO - mozversion == 1.4 03:37:53 INFO - psutil == 3.1.1 03:37:53 INFO - requests == 1.2.3 03:37:53 INFO - wsgiref == 0.1.2 03:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37: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')]} 03:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:53 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 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:53 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 03:37:53 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 03:37:53 INFO - Using env: {'DISPLAY': ':0', 03:37:53 INFO - 'HOME': '/home/cltbld', 03:37:53 INFO - 'LANG': 'en_US.UTF-8', 03:37:53 INFO - 'LANGUAGE': 'en_US:en', 03:37:53 INFO - 'LOGNAME': 'cltbld', 03:37:53 INFO - 'MAIL': '/var/mail/cltbld', 03:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:53 INFO - 'MOZ_NO_REMOTE': '1', 03:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:53 INFO - 'NO_EM_RESTART': '1', 03:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:53 INFO - 'PWD': '/builds/slave/test', 03:37:53 INFO - 'SHELL': '/bin/bash', 03:37:53 INFO - 'SHLVL': '1', 03:37:53 INFO - 'TERM': 'linux', 03:37:53 INFO - 'TMOUT': '86400', 03:37:53 INFO - 'USER': 'cltbld', 03:37:53 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:53 INFO - '_': '/tools/buildbot/bin/python'} 03:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 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)) 03:37:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:37:55 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)) 03:37:55 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)) 03:37:55 INFO - Installing collected packages: simplejson 03:37:55 INFO - Running setup.py install for simplejson 03:37:55 INFO - building 'simplejson._speedups' extension 03:37:55 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 03:37:56 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 03:37:56 INFO - Successfully installed simplejson 03:37:56 INFO - Cleaning up... 03:37:56 INFO - Return code: 0 03:37:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37: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')]} 03:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', '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 03:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:56 INFO - Using env: {'DISPLAY': ':0', 03:37:56 INFO - 'HOME': '/home/cltbld', 03:37:56 INFO - 'LANG': 'en_US.UTF-8', 03:37:56 INFO - 'LANGUAGE': 'en_US:en', 03:37:56 INFO - 'LOGNAME': 'cltbld', 03:37:56 INFO - 'MAIL': '/var/mail/cltbld', 03:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:56 INFO - 'MOZ_NO_REMOTE': '1', 03:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:56 INFO - 'NO_EM_RESTART': '1', 03:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:56 INFO - 'PWD': '/builds/slave/test', 03:37:56 INFO - 'SHELL': '/bin/bash', 03:37:56 INFO - 'SHLVL': '1', 03:37:56 INFO - 'TERM': 'linux', 03:37:56 INFO - 'TMOUT': '86400', 03:37:56 INFO - 'USER': 'cltbld', 03:37:56 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:56 INFO - '_': '/tools/buildbot/bin/python'} 03:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:56 INFO - Cleaning up... 03:37:56 INFO - Return code: 0 03:37:56 INFO - Running post-action listener: _resource_record_post_action 03:37:56 INFO - Running post-action listener: _start_resource_monitoring 03:37:56 INFO - Starting resource monitoring. 03:37:56 INFO - [mozharness: 2017-09-23 10:37:56.653408Z] Finished create-virtualenv step (success) 03:37:56 INFO - [mozharness: 2017-09-23 10:37:56.653938Z] Running install step. 03:37:56 INFO - Running pre-action listener: _resource_record_pre_action 03:37:56 INFO - Running main action method: install 03:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:56 INFO - Reading from file tmpfile_stdout 03:37:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:57 INFO - Reading from file tmpfile_stdout 03:37:57 INFO - Output received: 03:37:57 INFO - Usage: mozinstall [options] installer 03:37:57 INFO - Options: 03:37:57 INFO - -h, --help show this help message and exit 03:37:57 INFO - -d DEST, --destination=DEST 03:37:57 INFO - Directory to install application into. [default: 03:37:57 INFO - "/builds/slave/test"] 03:37:57 INFO - --app=APP Application being installed. [default: firefox] 03:37:57 INFO - mkdir: /builds/slave/test/build/application 03:37:57 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'] 03:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:38:14 INFO - Reading from file tmpfile_stdout 03:38:14 INFO - Output received: 03:38:14 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:14 INFO - Running post-action listener: _resource_record_post_action 03:38:14 INFO - [mozharness: 2017-09-23 10:38:14.795391Z] Finished install step (success) 03:38:14 INFO - [mozharness: 2017-09-23 10:38:14.795645Z] Running setup-mitmproxy step. 03:38:14 INFO - Running pre-action listener: _resource_record_pre_action 03:38:14 INFO - Running main action method: setup_mitmproxy 03:38:14 INFO - Skipping: mitmproxy is not required 03:38:14 INFO - Running post-action listener: _resource_record_post_action 03:38:14 INFO - [mozharness: 2017-09-23 10:38:14.796859Z] Finished setup-mitmproxy step (success) 03:38:14 INFO - [mozharness: 2017-09-23 10:38:14.797082Z] Running run-tests step. 03:38:14 INFO - Running pre-action listener: _resource_record_pre_action 03:38:14 INFO - Running pre-action listener: _set_gcov_prefix 03:38:14 INFO - Running main action method: run_tests 03:38:14 WARNING - Try message not found. 03:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:14 INFO - Python 2.7.3 03:38:14 INFO - Return code: 0 03:38:14 INFO - grabbing minidump binary from tooltool 03:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a0d60>, '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 0x13a1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:38:14 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:38:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:38:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:14 INFO - Return code: 0 03:38:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:14 INFO - ENV: RUST_BACKTRACE is now full 03:38:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 03:38:14 INFO - Using env: {'DISPLAY': ':0', 03:38:14 INFO - 'HOME': '/home/cltbld', 03:38:14 INFO - 'LANG': 'en_US.UTF-8', 03:38:14 INFO - 'LANGUAGE': 'en_US:en', 03:38:14 INFO - 'LOGNAME': 'cltbld', 03:38:14 INFO - 'MAIL': '/var/mail/cltbld', 03:38:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:14 INFO - 'MOZ_NO_REMOTE': '1', 03:38:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:14 INFO - 'NO_EM_RESTART': '1', 03:38:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:14 INFO - 'PWD': '/builds/slave/test', 03:38:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:14 INFO - 'RUST_BACKTRACE': 'full', 03:38:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:38:14 INFO - 'SHELL': '/bin/bash', 03:38:14 INFO - 'SHLVL': '1', 03:38:14 INFO - 'TERM': 'linux', 03:38:14 INFO - 'TMOUT': '86400', 03:38:14 INFO - 'USER': 'cltbld', 03:38:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:14 INFO - '_': '/tools/buildbot/bin/python'} 03:38:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:38:15 INFO - mozversion application_buildid: 20170923093829 03:38:15 INFO - mozversion application_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:38:15 INFO - mozversion application_display_name: Nightly 03:38:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:15 INFO - mozversion application_name: Firefox 03:38:15 INFO - mozversion application_remotingname: firefox 03:38:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:38:15 INFO - mozversion application_vendor: Mozilla 03:38:15 INFO - mozversion application_version: 58.0a1 03:38:15 INFO - mozversion platform_buildid: 20170923093829 03:38:15 INFO - mozversion platform_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:38:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:38:15 INFO - mozversion platform_version: 58.0a1 03:38:15 INFO - using testdate: 1506163095 03:38:15 INFO - actual date: 1506163095 03:38:15 INFO - starting webserver on 'localhost:37300' 03:38:15 INFO - SUITE-START | Running 2 tests 03:38:15 INFO - TEST-START | dromaeo_css 03:38:15 INFO - Initialising browser for dromaeo_css test... 03:38:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37300/getInfo.html -profile /tmp/tmpIQV4fo/profile 03:38:15 INFO - TEST-INFO | started process 12370 (/builds/slave/test/build/application/firefox/firefox http://localhost:37300/getInfo.html) 03:38:20 INFO - TEST-INFO | 12370: exit 0 03:38:20 INFO - Browser initialized. 03:38:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:20 INFO - Using env: {'DISPLAY': ':0', 03:38:20 INFO - 'HOME': '/home/cltbld', 03:38:20 INFO - 'JSGC_DISABLE_POISONING': '1', 03:38:20 INFO - 'LANG': 'en_US.UTF-8', 03:38:20 INFO - 'LANGUAGE': 'en_US:en', 03:38:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:38:20 INFO - 'LOGNAME': 'cltbld', 03:38:20 INFO - 'MAIL': '/var/mail/cltbld', 03:38:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:20 INFO - 'MOZ_CRASHREPORTER': '1', 03:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:38:20 INFO - 'MOZ_NO_REMOTE': '1', 03:38:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:20 INFO - 'NO_EM_RESTART': '1', 03:38:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:20 INFO - 'PWD': '/builds/slave/test', 03:38:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:20 INFO - 'RUST_BACKTRACE': 'full', 03:38:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:38:20 INFO - 'SHELL': '/bin/bash', 03:38:20 INFO - 'SHLVL': '1', 03:38:20 INFO - 'TERM': 'linux', 03:38:20 INFO - 'TMOUT': '86400', 03:38:20 INFO - 'USER': 'cltbld', 03:38:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:20 INFO - '_': '/tools/buildbot/bin/python'} 03:38:20 INFO - TEST-INFO | started process 12608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIQV4fo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:21 INFO - PID 12608 | 03:38:21 INFO - PID 12608 | (/builds/slave/test/build/application/firefox/firefox:12657): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:21 INFO - PID 12608 | 03:38:31 INFO - PID 12608 | RSS: Main: 151195648 03:38:31 INFO - PID 12608 | 03:41:29 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37300/tests/dromaeo/cssquery-ext.html) 03:41:30 INFO - PID 12608 | RSS: Main: 153063424 03:41:30 INFO - PID 12608 | 03:44:32 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-ext.html (next: http://localhost:37300/tests/dromaeo/cssquery-jquery.html) 03:44:32 INFO - PID 12608 | RSS: Main: 153231360 03:44:32 INFO - PID 12608 | 03:47:34 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37300/tests/dromaeo/cssquery-mootools.html) 03:47:35 INFO - PID 12608 | RSS: Main: 154636288 03:47:35 INFO - PID 12608 | 03:50:37 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37300/tests/dromaeo/cssquery-prototype.html) 03:50:37 INFO - PID 12608 | RSS: Main: 152834048 03:50:37 INFO - PID 12608 | 03:53:40 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37300/tests/dromaeo/cssquery-yui.html) 03:53:41 INFO - PID 12608 | RSS: Main: 154214400 03:53:41 INFO - PID 12608 | 03:56:42 INFO - PID 12608 | Cycle 1(1): loaded http://localhost:37300/tests/dromaeo/cssquery-yui.html (next: http://localhost:37300/tests/dromaeo/cssquery-dojo.html) 03:56:43 INFO - PID 12608 | RSS: Main: 156848128 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | __start_tp_report 03:56:43 INFO - PID 12608 | _x_x_mozilla_page_load 03:56:43 INFO - PID 12608 | _x_x_mozilla_page_load_details 03:56:43 INFO - PID 12608 | |i|pagename|runs| 03:56:43 INFO - PID 12608 | |0;dojo.html;3107.95338069929;3121.4069326827903;3144.6855314468557;3160.336329370832;3168.841557922103;6184.69076546172;6299.77950771723;6343.968280158599;6365.777197798078;6390.233172019352;6259.029850373199;6297.5276854236;6314.116023756677;6340.7463701452;6470.838229044276;5835.708214589275;5894.410558944114;5907.084401917709;5914.88170236595;5918.88162236755;5714.200011998323;5814.273215848019;5862.2965244170755;5893.793717219898;5924.58527903047;5850.736716847752;5854.895637284022;5887.970560147171;5910.261217347832;5940.524758019348;5742.7415766290615;5759.539236861041;5797.304323481167;5815.854603634901;5865.85335366615;5717.571182161313;5765.394633563499;5766.942330576724;5806.564507661942;5807.477327040544;6263.592866463665;6285.87428251437;6292.056191571255;6294.244690637107;6361.3638636136475;6609.272979972199;6668.433183179435;6710.698018589175;6738.93261067388;6826.897596536056;6773.593584384904;6791.422729068036;6802.14973128359;6850.623215723133;6945.89581156283;6334.398232167937;6393.776217832354;6410.166678331787;6412.839679008015;6418.06937993993;6949.965250173716;6969.128858892638;6980.267071957473;7044.859102818017;7068.469864760164;6479.254885688206;6624.27133015368;6650.70071846768;6727;6749.898751518731;6728.562643428161;6797.048413222153;6855.211650660238;6866.862662746817;6874.828129296808;6565.967170164118;6670.633115178614;6773.695183716744;6787.762428314985;6858.211305699809;6726.529142960044;6737.225219099866;6743.190817101881;6743.730250789913;6746.932530674729;5297;5319.654222475604;5332.0402327581405;5388.568914486832;5400.270963419966;4704.3649107370065;4745.786439610226;4764.4282686077895;4769.260764581495;4795.064962332382;5724.284464441945;5839.591228613956;5884.176215329857;5894.764209431574;5931.822045338647;6636.236832764197;6755.49333799967;6781.525293229427;6838.487113466411;6875.931240687529;5846.590738648339;5862.824115276549;5888.087346461305;5891.882162356729;5893.44012318829;5800.477956983892;5809.925163844618;5839.328477225174;5912.733926973297;5916.26046744157;6383.106365108889;6498.187726534184;6565.80302590923;6637.070810086591;6642.169728783902;6780.084688566981;6875.243723190545;6878.3465570770695;6883.27725588826;6891.241963383924;6542.869142617026;6651.16860392451;6667.666616669244;6669.333066693292;6672.466202703675;6695.196576410667;6698.732050718112;6729.798106056826;6792.320767923168;6809.319068093151;6750.966245168743;6799.422049125879;6827.89758153638;6862.416694581017;6867.21027081872;6615.966920165369;6629.46964242869;6630.237522684953;6634.0712300278965;6656.400923916871;6525.347465253437;6526.184226971629;6554.377334153248;6556.18047744032;6675.766348177791;6458.418742313214;6501.804945851632;6526.118973938647;6527.934720652733;6533.314002029719;6614.404703576702;6651.73393064272;6656.467482601477;6670.699818508082;6680.83297917556;6345.460635846005;6364.109024736633;6367.267764207176;6442.194725659293;6443.323451037573 03:56:43 INFO - PID 12608 | |1;ext.html;812.5774597209447;843.7426584891607;869.0874581689225;870.0820634230884;871.0723079919885;40700.59299407005;41354.58645413549;41442.79278603603;41475.792621036926;41547.58452415479;37886;40760.18479630406;41444.792776036156;41464.79267603665;41558.16883662325;7866.016747906526;7989.720359787409;8001.7199398021085;8009.479383840061;8010.239027292427;7708.11356693979;7774.65014074368;7832.412569057315;7886.842263154734;7892.605369731519;7766.57283849388;7854.607269636524;7855.960720196391;7879.093904201033;7886.171951945049;7790.298873101419;7792.610369481503;7826.765197044069;7836.843263134705;7864.449488535804;7741.729039483647;7798;7829.765107046797;7849.097353804328;7850.214978502161;38167.236655267014;38180.80909595434;38457.230855383015;38533.614663853565;38542.61457385418;3524.1189702574356;3526.1713497328105;3542.415501442259;3552.928941421183;3557.7331700122336;31143.844280778678;31202.219944501343;31301.843490782627;31324;31357;4960.87597810054;5137.3064636274;5184.585233181374;5212.6611770235195;5223.425423203483;178927;182152;188241;189318;198567;47779.5222047782;47932.28101578479;48261.75869120632;48282.51717482851;48355;49662.75168624134;49740.75129624329;49851.75074124606;49905.75047124814;49944.25083623749;15314;15499.845001550066;15536.844631553766;15565.14391708467;15965.882388232712;13005.739885202243;13039.152455090389;13049.804252936214;13062.54281100157;13063.412146453433;13338.266395348155;13466.394012269471;13491.527796527074;13509.2569908654;13641.795373069412;5166.974165129225;5220.919657402151;5251.632385733038;5348.277982472394;5416.972915135478;1013.2350075692805;1014.0569270578433;1026.343140390151;1028.804527139841;1044.6970378590277;22519.32442026709;22535.774642253367;22638.320850374515;22953.19663811792;23031;1117.4915413486844;1119.630521927778;1135.6593022093339;1142.8400023996646;1146.0201527693869;11901.642950711492;12030.338331391857;12096.939515302367;12116.15186936906;12197.817032744517;217121;217290;217715;218106;218578;52207.477925220264;52208.216876746876;52242.21636675453;52245.47754522482;52344.47655523472;1450.91294522329;1463.3122432456728;1464.1068947941747;1468.2585294426246;1472.7349077166214;21681;22293.10827566879;22402.551948960605;22622.208222712125;22706.318810435714;36993.81503092467;37028;37039;37049.81475092715;37056.814715926244;185575;185795;186324.06837965723;186696;186802.06598966918;33881;34968.82515587406;35652.7521536745;35716.64283357237;35729.1067723309;45158;45707.77146114248;45830.54169458396;45863.77068114638;46060.07879842451;32304.83847580747;32465.35069298648;32484.675153248165;32782;33042;32431;32781.672183277864;32963.34073318568;33119.337613248084;33668.83165584156;35907.64092359043;36398.27203455969;36787.08032299214;36812.44781328336;36866;31570.842145789124;31864.68135318617;32369.35261294808;32551;32812.34375312528;23853.403664908517;23857.403564911016;23891.40271493157;23961.52076958486;24020.759792401852 03:56:43 INFO - PID 12608 | |2;jquery.html;582.6766144789643;603.3001718007113;605.3855336833112;617.8702472480779;638.6838514935108;22022.779772202273;22543.54912901741;22548.3235502935;22575.54848903021;22625.547489050252;22482.213122540714;24368.634470482957;24481.265562033168;24485.755142448572;24566;6406.295307516181;6600.834979125512;6602.372774586406;6603.9669801650925;6611.801645950629;6289.685515724218;6503.544751867371;6600.834979125536;6605.306442823507;6611.206655201383;6496.707648155821;6522.380373864476;6523.739050437976;6533.31400202979;6533.738650453976;6530.8040758777315;6536.182977127859;6539.247986481568;6539.869202615945;6542.509311801587;5800.158976948319;6013.879722405572;6014.338422773535;6022.638641681513;6077.604955677867;28329.716702832913;28536;28635.57046644302;28638.284042898886;28753;1923.3460623387975;1969.2123150739676;1970.1725275384374;1970.9901450492798;1971.940841774749;18858.811411885843;19166.808331916644;19595.706064409045;19661.410157695293;19975.101120449468;2442.792362649177;2469.5431345201014;2474.938126546833;2505.448801263719;2512.886920088582;121661;126832;133149;136570;143482.56517434795;14769.704605907822;14834.258287085602;14903.368001239562;14941.310564098567;15073.623159421102;22339;22538;22608.321750347517;22612.30407719395;22626.886865565568;9513.096255855682;9560.235181185488;9698.70903872885;9783.168430683472;9866.753331166778;8668.60991255395;8674.262687671619;8763.693270735494;8775.210231079234;8784.385093043553;8977.955110224537;9117.179453849185;9120.817583648422;9150.22223111043;9169.40398874071;2742.75315221631;2796.5385711357803;2800.6219160413084;2804.6213761141985;2875.2236896037953;953.2802733935835;966.3042609321277;970.8496178835535;973.6689525561343;973.9659111931048;18206.908965455354;18633.627327453374;18868.905655471634;19096.90451547761;19284.614307713768;986.1312812220945;1009.6062535611118;1019.6940917724653;1024.1806554756165;1033.3180101133216;10290.3825770454;10415.479226038668;10542.947285263677;10555.736106597396;10779.67660970172;455036;458974;461208;464426;467649;101618;102476;103553.96446035443;103876.48061759795;106830;1123.9213255072066;1139.2594813371209;1157.4849192109598;1159.60573405041;1168.4449886304108;16659.25033373477;16679.49961501157;16760.078195699352;16933.230393743732;17239.310427582757;56116.43883561112;56135.719321404766;56788.71605641946;57675.42324576868;58338.249852504494;66435.66782166252;66640;66860.6656966712;67592;67906.98139527813;13706.931465343008;13805.79291310611;13854.30728463593;13861.930690346888;13966;21021.789782101983;21437.46406339854;21624.89187554115;21832.45418864541;21867.890660546596;17215.655686886443;17340.653186936444;17689.646207076043;17694.557636059202;17723.645527089127;15412.152331621868;15816.920915395349;15968;16161.4343497977;16373.42693005739;16763.49709508717;17184;17477.300907963538;17890.28438862431;17969.101544922964;13717.17696938187;13831.930840345734;13934.721305574034;13939.930300348433;13963.092398994033;17397.130143492523;17587.472375828747;17600.823991759917;17675.46973590743;17699.38052168168 03:56:43 INFO - PID 12608 | |3;mootools.html;1346.3739361197045;1402.4179965314395;1409.2178840743384;1415.0731271017485;1426.1728197645366;14921;15694.293756780944;15707.371705131794;15707.450239241629;15776.368945242206;15924.20378981052;16262.75605865913;16275.430359937405;16282.348706051773;16288.511344659679;2809.8620058876086;2863.6134121893488;2865.5844902489125;2865.856707164644;2868.153894601098;2716.5517689581197;2793.092245020366;2816.2818481287245;2865.269356314137;2866.082853486885;2790.4419116176746;2802.3134332088666;2806.873690683914;2814.8170368926058;2817.3942602340494;2747.917562473129;2750.917472475829;2774.389634280455;2795.4269374778123;2798.1325789005373;2729.9454010919867;2748.9037883674177;2759.6274502942047;2764;2764.074035198211;14879.18164500952;15231.466898658493;15270.38918443272;15315.693686126215;15358.692826143415;8067.031956165239;8239.876401853977;8349.165083491664;8349.41554091214;8351.415400921938;5218.269442278084;5429.945700542983;5498.230247765316;5501.202325662796;5511.944880551183;1966.488712934633;2002.2991952816544;2028.523297025198;2058.464799152216;2074.2740040985686;27787.444251114863;28003.85998070017;28064.719352806416;28066;28123.57814632782;6842.178938527409;6871.656417179221;7120.857582848314;7202.171750248788;7317.451191160578;18100.185491652643;18109.7283540747;18118.909405453152;18120.63758724818;18133.45599632013;8122.944017277716;8238.588070596446;8285.295749861209;8288.50268983863;8292.12932642064;7455.813604659818;7621.733239336597;7668.923310766932;7684.3084122429245;7685.154632990367;4851.830185943475;5302.496262855023;5494.325703151672;5511.063119269734;5668.9716551417805;1460.532629558531;1585.8969167004109;1602.9100211855816;1634.5750104972792;1649.4556796257207;854.4061876995429;866.1425189062783;872.2760109109424;884.1997991817416;887.2857349833317;7782.533048017137;7935.285824275843;8138.593070346577;8142.51144931306;8226.629801658939;985.6008316631776;1004.352192835617;1005.4520286443906;1006.8036732837173;1007.2244371833793;4184.769837658958;4268.722533035405;4324.740515569013;4326.913461730748;4348.152110338517;21465;21760.89119554392;21902.23342183016;22586.548269034854;22664.660030099563;20944.685829712565;21493.78506214949;22396.10415583391;22580.322590322317;22615.321540353816;11506.137039722222;11552.480138393792;11645.708857278467;11752;11757.88242117585;7801.1808760079375;8048.557329346942;8052.396070294869;8089.312408445348;8151.551664658264;18046.909765451088;18675.43973680792;18756.718649219998;18837.340693076225;19139.13873875707;19113.713294300876;19190.8080919189;19238.80761192426;19513.512162196057;19737.90131049393;11266.7746645065;11330.60342887995;11445.48495317696;11468.4265786712;11469.254498457907;12720.491180352683;14184.716305673623;14363.138211707332;14364.640883977983;14377.64055898611;11533.365664888512;11574.768504629692;11775.587854425397;11801.29192248468;11942.223755455867;11008.834867476835;11155.888441115809;11301.43492825339;11317.490712918103;11346.205765596329;9225.86161207569;9333.626654933998;9335.953320233355;9374.250059995047;9433.151016408556;6823.1812182538415;6850;6877.174739031148;7011.228764835762;7071.575705457689;7298.23368546295;7385.372243359375;7387.963060184879;7477.962610187132;7588 03:56:43 INFO - PID 12608 | |4;prototype.html;501.29278168056686;531.6464551073536;532.8658721819114;535.9598030147739;542.7828868452618;6290.811275661732;6305.653189074599;6334.493240540757;6361.4274715275615;6362.268339141;6122.499987503057;6181.412765787243;6206.379362063792;6258.84352891178;6318.147050148229;5190.506901844319;5219.321488206538;5232.215167724834;5244.816431424901;5252.185911183773;4893.094777466163;5217.165253559431;5220.1110172921035;5221.590170653921;5239.476052394768;5029.497050294959;5041.621878359119;5044.772985215674;5050.570701490377;5052.646314757969;5028.195488721805;5029.145045342282;5044.520770526794;5047.738065483629;5069.087564238435;4542.114287713897;4546;4548.818047278105;4556.225441674923;4561.6806823522365;6180.1347811306005;6202.255729312466;6217.285012223607;6232.6288216592275;6244.219472565929;5795.159701843251;5796.13058041293;5796.710164491801;5802.912956305659;5812.534997200256;6572.572782769153;6595.670216489204;6609.001554059772;6637.137172167587;6648.16897887764;4916.680415772963;4931.186354251544;4942.851714448537;4944.53026962438;4945.9258111128365;6604.438622717074;6727.29363416844;6816.386525212754;6925;6928.965355173243;5031.647784655039;5042.823501177441;5048.16705243638;5048.217526283432;5052.166392545262;5026.472220416877;5078.669886457368;5088.1350170471105;5126.820561280338;5130.230465430215;5661.377248502661;5665.5467562594895;5683.488486036276;5713.314402271754;5760.913586296209;6605.30644282353;6628.4697224221945;6651.567648102858;6670.866582668416;6694.828405029198;1753.4126067767186;1762.7444020617195;1764.2413762082429;1776;1789.150153676993;1171.5313874450287;1221.2428294457493;1225.4424236972156;1229.2624425344723;1260.4139075330015;5615.742869135891;5631.352394474606;5644.238027866186;5652.63257888236;5758.12671075509;6663.867142585772;6681.198256209286;6697.665116744143;6754.966225168842;6785.694643741043;5613.775448982076;5619.26949496571;5619.831405057773;5646.6047376684055;5726.9713651431475;3575.2313252650806;3589.6230895756094;3595.640435956436;3613.457981302826;3614.644508309384;6442.613443193423;6500.154979852589;6520.250171230369;6530.673466326664;6534;6469.838254043592;6720.966395167993;6840.931590684129;6913.619750913748;6945.826354341182;6323.620582765049;6326.620402775849;6447.871042579122;6492.740290388426;6570.934290657128;6605.636689981905;6632.1709786276715;6674.733010679518;6690.397864192246;6702.597844129368;6667.53327267106;6678.933210668026;6687.933120668731;6700.6984685688285;6780.660966951731;6490.578112422866;6503.6097834130105;6537.673116344069;6554.705038273384;6556.3443655634055;5033.169527028;5039.168537191323;5041.395032596112;5058.443571207091;5064.594832413324;6419.325970773189;6615.37153970372;6650.46796256308;6812.625305608239;6822.863542729018;6276.874462510816;6493.461063720379;6500.349965003462;6506.154199953976;6563.9343606565235;6462.159919210472;6514.869702606016;6538.057873956644;6556.508261880283;6573.516036500662;6353.650549219838;6376.458001069961;6392.712327945346;6415.262244841903;6480.384363485461;6519.771807986887;6524.804255872332;6584.736610535717;6633;6646.4350530205475;6307.400796924285;6344.382182543422;6370.58591191571;6387.105805187371;6408.1349017881985 03:56:43 INFO - PID 12608 | |5;yui.html;910.3445519226154;921.594498420695;930.3115694386156;947.7962238118803;959.3045042344299;19524.219031238732;20479.078441470134;20495.692564611523;20510.487237819045;20544.486387840312;19077.236910523563;19079.61840763184;19298.4210473686;19834.603307933834;19848.80151198491;962.2638681408728;976.4727047394399;977.8435450327949;977.9315447918613;978;962.5283611030615;999.4153420249163;1004.1765752083259;1004.9949750251238;1005.316384858296;1048.6487026846016;1054.3357684658654;1055.2613170780446;1055.3456856748826;1061.0821639282042;1043.9895601043968;1047.0628787235419;1047.4343854318658;1049.7533079726259;1050.7058023753323;725.8548290341953;747.096013823269;753.4311594745986;753.5516367761173;771.2133623703846;20427.89786051075;20663.690044649342;20739.27412540569;20914.37256882296;20999;21827.890860545755;21925.890370548204;22516;22577.774222257733;22701.31896043105;17238;17669.469915902544;17705.55736106595;17713.55716107095;17718;3520.1903562180587;3539.50446937429;3567.3222087803492;3575.713942884563;3576.088097535138;135870.32064839613;137528;139173;140286;142182;16467.34130634761;16801.495955121365;16852.24164912582;16863.831361686225;16892.91553542249;30628.54057189144;30877.8456107718;31274;31775.04674859758;31964;9247.26021918245;9253.537323133816;9316.114969077928;9322.25421966241;9329.673461428818;4184.225918205142;4191.098913733501;4207.915841683211;4223.68322375823;4293.034067334825;5463.399026107125;5575.553955683536;5593.300837395325;5603.047481928082;5609.887802243932;966.1546147121269;986.2849434160177;1005.1606908231709;1006.2201793610011;1008.349614498659;593.7239183779564;599.3916175082295;619.2723549828933;623.9032949892683;625.4902254662436;10609.098226650822;11284.560461188199;11511.942440287745;12053.457594408274;12196.207246528948;633.3191818794722;641.3298103481873;646.8997305417668;649.1074772188241;666.1872515531045;5602.467765562265;5631.014572449805;5648.491635752802;5654.37801841797;5812.215350927655;111092;113384;113472;114764;117427;99210;99834.5008274954;100157;100176;100230;86741.5662921694;93120.53439732894;93219;93363;94122.46979248484;10318.896811031793;10397.636082737068;10450.738731531772;10712.57149714034;10779.407132607781;43744;44333;44485;44571.554284458034;45786.54213457823;53656.195157071896;53830;54685;55282.170767439326;55297.44702552923;15287.770683439534;15561.76657350118;15682;15718.76421853696;15787.921060394625;17348.913255433643;17410.738838917172;17480.47558573245;17645.29418823284;17659;15494.922525387301;15627.765583516484;15751.44869929547;15792.842071579596;15892.125933073792;15857.444989425314;15944;15971.44099956496;16138.919305403399;16166.838331616533;14736.926315368783;14746.262686865828;14773.556793296219;14923.104613723212;14934.626634334229;11260.549578016788;11302.943485282522;11464.713382165513;11501.424928753697;11698.181127321006;11037.834432483358;11098.61154859576;11311.717207069889;11315;11358.772824543297 03:56:43 INFO - PID 12608 | __end_tp_report 03:56:43 INFO - PID 12608 | __start_cc_report 03:56:43 INFO - PID 12608 | _x_x_mozilla_cycle_collect,301 03:56:43 INFO - PID 12608 | __end_cc_report 03:56:43 INFO - PID 12608 | __startTimestamp1506164203237__endTimestamp 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | ------- Summary: start ------- 03:56:43 INFO - PID 12608 | Number of tests: 6 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#0] dojo.html Cycles:165 Average:6242.69 Median:6479.25 stddev:744.80 (11.5%) stddev-sans-first:705.32 03:56:43 INFO - PID 12608 | Values: 3108.0 3121.4 3144.7 3160.3 3168.8 6184.7 6299.8 6344.0 6365.8 6390.2 6259.0 6297.5 6314.1 6340.7 6470.8 5835.7 5894.4 5907.1 5914.9 5918.9 5714.2 5814.3 5862.3 5893.8 5924.6 5850.7 5854.9 5888.0 5910.3 5940.5 5742.7 5759.5 5797.3 5815.9 5865.9 5717.6 5765.4 5766.9 5806.6 5807.5 6263.6 6285.9 6292.1 6294.2 6361.4 6609.3 6668.4 6710.7 6738.9 6826.9 6773.6 6791.4 6802.1 6850.6 6945.9 6334.4 6393.8 6410.2 6412.8 6418.1 6950.0 6969.1 6980.3 7044.9 7068.5 6479.3 6624.3 6650.7 6727.0 6749.9 6728.6 6797.0 6855.2 6866.9 6874.8 6566.0 6670.6 6773.7 6787.8 6858.2 6726.5 6737.2 6743.2 6743.7 6746.9 5297.0 5319.7 5332.0 5388.6 5400.3 4704.4 4745.8 4764.4 4769.3 4795.1 5724.3 5839.6 5884.2 5894.8 5931.8 6636.2 6755.5 6781.5 6838.5 6875.9 5846.6 5862.8 5888.1 5891.9 5893.4 5800.5 5809.9 5839.3 5912.7 5916.3 6383.1 6498.2 6565.8 6637.1 6642.2 6780.1 6875.2 6878.3 6883.3 6891.2 6542.9 6651.2 6667.7 6669.3 6672.5 6695.2 6698.7 6729.8 6792.3 6809.3 6751.0 6799.4 6827.9 6862.4 6867.2 6616.0 6629.5 6630.2 6634.1 6656.4 6525.3 6526.2 6554.4 6556.2 6675.8 6458.4 6501.8 6526.1 6527.9 6533.3 6614.4 6651.7 6656.5 6670.7 6680.8 6345.5 6364.1 6367.3 6442.2 6443.3 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#1] ext.html Cycles:180 Average:36845.51 Median:3555.33 stddev:51156.25 (1438.9%) stddev-sans-first:51228.21 03:56:43 INFO - PID 12608 | Values: 812.6 843.7 869.1 870.1 871.1 40700.6 41354.6 41442.8 41475.8 41547.6 37886.0 40760.2 41444.8 41464.8 41558.2 7866.0 7989.7 8001.7 8009.5 8010.2 7708.1 7774.7 7832.4 7886.8 7892.6 7766.6 7854.6 7856.0 7879.1 7886.2 7790.3 7792.6 7826.8 7836.8 7864.4 7741.7 7798.0 7829.8 7849.1 7850.2 38167.2 38180.8 38457.2 38533.6 38542.6 3524.1 3526.2 3542.4 3552.9 3557.7 31143.8 31202.2 31301.8 31324.0 31357.0 4960.9 5137.3 5184.6 5212.7 5223.4 178927.0 182152.0 188241.0 189318.0 198567.0 47779.5 47932.3 48261.8 48282.5 48355.0 49662.8 49740.8 49851.8 49905.8 49944.3 15314.0 15499.8 15536.8 15565.1 15965.9 13005.7 13039.2 13049.8 13062.5 13063.4 13338.3 13466.4 13491.5 13509.3 13641.8 5167.0 5220.9 5251.6 5348.3 5417.0 1013.2 1014.1 1026.3 1028.8 1044.7 22519.3 22535.8 22638.3 22953.2 23031.0 1117.5 1119.6 1135.7 1142.8 1146.0 11901.6 12030.3 12096.9 12116.2 12197.8 217121.0 217290.0 217715.0 218106.0 218578.0 52207.5 52208.2 52242.2 52245.5 52344.5 1450.9 1463.3 1464.1 1468.3 1472.7 21681.0 22293.1 22402.6 22622.2 22706.3 36993.8 37028.0 37039.0 37049.8 37056.8 185575.0 185795.0 186324.1 186696.0 186802.1 33881.0 34968.8 35652.8 35716.6 35729.1 45158.0 45707.8 45830.5 45863.8 46060.1 32304.8 32465.4 32484.7 32782.0 33042.0 32431.0 32781.7 32963.3 33119.3 33668.8 35907.6 36398.3 36787.1 36812.4 36866.0 31570.8 31864.7 32369.4 32551.0 32812.3 23853.4 23857.4 23891.4 23961.5 24020.8 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#2] jquery.html Cycles:180 Average:33006.15 Median:22591.94 stddev:77690.90 (343.9%) stddev-sans-first:77870.70 03:56:43 INFO - PID 12608 | Values: 582.7 603.3 605.4 617.9 638.7 22022.8 22543.5 22548.3 22575.5 22625.5 22482.2 24368.6 24481.3 24485.8 24566.0 6406.3 6600.8 6602.4 6604.0 6611.8 6289.7 6503.5 6600.8 6605.3 6611.2 6496.7 6522.4 6523.7 6533.3 6533.7 6530.8 6536.2 6539.2 6539.9 6542.5 5800.2 6013.9 6014.3 6022.6 6077.6 28329.7 28536.0 28635.6 28638.3 28753.0 1923.3 1969.2 1970.2 1971.0 1971.9 18858.8 19166.8 19595.7 19661.4 19975.1 2442.8 2469.5 2474.9 2505.4 2512.9 121661.0 126832.0 133149.0 136570.0 143482.6 14769.7 14834.3 14903.4 14941.3 15073.6 22339.0 22538.0 22608.3 22612.3 22626.9 9513.1 9560.2 9698.7 9783.2 9866.8 8668.6 8674.3 8763.7 8775.2 8784.4 8978.0 9117.2 9120.8 9150.2 9169.4 2742.8 2796.5 2800.6 2804.6 2875.2 953.3 966.3 970.8 973.7 974.0 18206.9 18633.6 18868.9 19096.9 19284.6 986.1 1009.6 1019.7 1024.2 1033.3 10290.4 10415.5 10542.9 10555.7 10779.7 455036.0 458974.0 461208.0 464426.0 467649.0 101618.0 102476.0 103554.0 103876.5 106830.0 1123.9 1139.3 1157.5 1159.6 1168.4 16659.3 16679.5 16760.1 16933.2 17239.3 56116.4 56135.7 56788.7 57675.4 58338.2 66435.7 66640.0 66860.7 67592.0 67907.0 13706.9 13805.8 13854.3 13861.9 13966.0 21021.8 21437.5 21624.9 21832.5 21867.9 17215.7 17340.7 17689.6 17694.6 17723.6 15412.2 15816.9 15968.0 16161.4 16373.4 16763.5 17184.0 17477.3 17890.3 17969.1 13717.2 13831.9 13934.7 13939.9 13963.1 17397.1 17587.5 17600.8 17675.5 17699.4 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#3] mootools.html Cycles:180 Average:9505.09 Median:2764.04 stddev:6909.68 (250.0%) stddev-sans-first:6901.87 03:56:43 INFO - PID 12608 | Values: 1346.4 1402.4 1409.2 1415.1 1426.2 14921.0 15694.3 15707.4 15707.5 15776.4 15924.2 16262.8 16275.4 16282.3 16288.5 2809.9 2863.6 2865.6 2865.9 2868.2 2716.6 2793.1 2816.3 2865.3 2866.1 2790.4 2802.3 2806.9 2814.8 2817.4 2747.9 2750.9 2774.4 2795.4 2798.1 2729.9 2748.9 2759.6 2764.0 2764.1 14879.2 15231.5 15270.4 15315.7 15358.7 8067.0 8239.9 8349.2 8349.4 8351.4 5218.3 5429.9 5498.2 5501.2 5511.9 1966.5 2002.3 2028.5 2058.5 2074.3 27787.4 28003.9 28064.7 28066.0 28123.6 6842.2 6871.7 7120.9 7202.2 7317.5 18100.2 18109.7 18118.9 18120.6 18133.5 8122.9 8238.6 8285.3 8288.5 8292.1 7455.8 7621.7 7668.9 7684.3 7685.2 4851.8 5302.5 5494.3 5511.1 5669.0 1460.5 1585.9 1602.9 1634.6 1649.5 854.4 866.1 872.3 884.2 887.3 7782.5 7935.3 8138.6 8142.5 8226.6 985.6 1004.4 1005.5 1006.8 1007.2 4184.8 4268.7 4324.7 4326.9 4348.2 21465.0 21760.9 21902.2 22586.5 22664.7 20944.7 21493.8 22396.1 22580.3 22615.3 11506.1 11552.5 11645.7 11752.0 11757.9 7801.2 8048.6 8052.4 8089.3 8151.6 18046.9 18675.4 18756.7 18837.3 19139.1 19113.7 19190.8 19238.8 19513.5 19737.9 11266.8 11330.6 11445.5 11468.4 11469.3 12720.5 14184.7 14363.1 14364.6 14377.6 11533.4 11574.8 11775.6 11801.3 11942.2 11008.8 11155.9 11301.4 11317.5 11346.2 9225.9 9333.6 9336.0 9374.3 9433.2 6823.2 6850.0 6877.2 7011.2 7071.6 7298.2 7385.4 7388.0 7478.0 7588.0 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#4] prototype.html Cycles:180 Average:5534.06 Median:6224.96 stddev:1532.98 (24.6%) stddev-sans-first:1490.01 03:56:43 INFO - PID 12608 | Values: 501.3 531.6 532.9 536.0 542.8 6290.8 6305.7 6334.5 6361.4 6362.3 6122.5 6181.4 6206.4 6258.8 6318.1 5190.5 5219.3 5232.2 5244.8 5252.2 4893.1 5217.2 5220.1 5221.6 5239.5 5029.5 5041.6 5044.8 5050.6 5052.6 5028.2 5029.1 5044.5 5047.7 5069.1 4542.1 4546.0 4548.8 4556.2 4561.7 6180.1 6202.3 6217.3 6232.6 6244.2 5795.2 5796.1 5796.7 5802.9 5812.5 6572.6 6595.7 6609.0 6637.1 6648.2 4916.7 4931.2 4942.9 4944.5 4945.9 6604.4 6727.3 6816.4 6925.0 6929.0 5031.6 5042.8 5048.2 5048.2 5052.2 5026.5 5078.7 5088.1 5126.8 5130.2 5661.4 5665.5 5683.5 5713.3 5760.9 6605.3 6628.5 6651.6 6670.9 6694.8 1753.4 1762.7 1764.2 1776.0 1789.2 1171.5 1221.2 1225.4 1229.3 1260.4 5615.7 5631.4 5644.2 5652.6 5758.1 6663.9 6681.2 6697.7 6755.0 6785.7 5613.8 5619.3 5619.8 5646.6 5727.0 3575.2 3589.6 3595.6 3613.5 3614.6 6442.6 6500.2 6520.3 6530.7 6534.0 6469.8 6721.0 6840.9 6913.6 6945.8 6323.6 6326.6 6447.9 6492.7 6570.9 6605.6 6632.2 6674.7 6690.4 6702.6 6667.5 6678.9 6687.9 6700.7 6780.7 6490.6 6503.6 6537.7 6554.7 6556.3 5033.2 5039.2 5041.4 5058.4 5064.6 6419.3 6615.4 6650.5 6812.6 6822.9 6276.9 6493.5 6500.3 6506.2 6563.9 6462.2 6514.9 6538.1 6556.5 6573.5 6353.7 6376.5 6392.7 6415.3 6480.4 6519.8 6524.8 6584.7 6633.0 6646.4 6307.4 6344.4 6370.6 6387.1 6408.1 03:56:43 INFO - PID 12608 | 03:56:43 INFO - PID 12608 | [#5] yui.html Cycles:180 Average:23705.81 Median:20453.49 stddev:33757.77 (165.0%) stddev-sans-first:33809.08 03:56:43 INFO - PID 12608 | Values: 910.3 921.6 930.3 947.8 959.3 19524.2 20479.1 20495.7 20510.5 20544.5 19077.2 19079.6 19298.4 19834.6 19848.8 962.3 976.5 977.8 977.9 978.0 962.5 999.4 1004.2 1005.0 1005.3 1048.6 1054.3 1055.3 1055.3 1061.1 1044.0 1047.1 1047.4 1049.8 1050.7 725.9 747.1 753.4 753.6 771.2 20427.9 20663.7 20739.3 20914.4 20999.0 21827.9 21925.9 22516.0 22577.8 22701.3 17238.0 17669.5 17705.6 17713.6 17718.0 3520.2 3539.5 3567.3 3575.7 3576.1 135870.3 137528.0 139173.0 140286.0 142182.0 16467.3 16801.5 16852.2 16863.8 16892.9 30628.5 30877.8 31274.0 31775.0 31964.0 9247.3 9253.5 9316.1 9322.3 9329.7 4184.2 4191.1 4207.9 4223.7 4293.0 5463.4 5575.6 5593.3 5603.0 5609.9 966.2 986.3 1005.2 1006.2 1008.3 593.7 599.4 619.3 623.9 625.5 10609.1 11284.6 11511.9 12053.5 12196.2 633.3 641.3 646.9 649.1 666.2 5602.5 5631.0 5648.5 5654.4 5812.2 111092.0 113384.0 113472.0 114764.0 117427.0 99210.0 99834.5 100157.0 100176.0 100230.0 86741.6 93120.5 93219.0 93363.0 94122.5 10318.9 10397.6 10450.7 10712.6 10779.4 43744.0 44333.0 44485.0 44571.6 45786.5 53656.2 53830.0 54685.0 55282.2 55297.4 15287.8 15561.8 15682.0 15718.8 15787.9 17348.9 17410.7 17480.5 17645.3 17659.0 15494.9 15627.8 15751.4 15792.8 15892.1 15857.4 15944.0 15971.4 16138.9 16166.8 14736.9 14746.3 14773.6 14923.1 14934.6 11260.5 11302.9 11464.7 11501.4 11698.2 11037.8 11098.6 11311.7 11315.0 11358.8 03:56:43 INFO - PID 12608 | -------- Summary: end -------- 03:56:43 INFO - PID 12608 | 03:56:43 INFO - TEST-INFO | 12608: exit 0 03:56:43 INFO - TEST-OK | dromaeo_css | took 1108766ms 03:56:43 INFO - TEST-START | kraken 03:56:43 INFO - Initialising browser for kraken test... 03:56:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37300/getInfo.html -profile /tmp/tmp5D3mo3/profile 03:56:43 INFO - TEST-INFO | started process 12977 (/builds/slave/test/build/application/firefox/firefox http://localhost:37300/getInfo.html) 03:56:48 INFO - TEST-INFO | 12977: exit 0 03:56:48 INFO - Browser initialized. 03:56:48 INFO - Running cycle 1/1 for kraken test... 03:56:48 INFO - Using env: {'DISPLAY': ':0', 03:56:48 INFO - 'HOME': '/home/cltbld', 03:56:48 INFO - 'JSGC_DISABLE_POISONING': '1', 03:56:48 INFO - 'LANG': 'en_US.UTF-8', 03:56:48 INFO - 'LANGUAGE': 'en_US:en', 03:56:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:56:48 INFO - 'LOGNAME': 'cltbld', 03:56:48 INFO - 'MAIL': '/var/mail/cltbld', 03:56:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:48 INFO - 'MOZ_CRASHREPORTER': '1', 03:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:56:48 INFO - 'MOZ_NO_REMOTE': '1', 03:56:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:48 INFO - 'NO_EM_RESTART': '1', 03:56:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:48 INFO - 'PWD': '/builds/slave/test', 03:56:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:48 INFO - 'RUST_BACKTRACE': 'full', 03:56:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:56:48 INFO - 'SHELL': '/bin/bash', 03:56:48 INFO - 'SHLVL': '1', 03:56:48 INFO - 'TERM': 'linux', 03:56:48 INFO - 'TMOUT': '86400', 03:56:48 INFO - 'USER': 'cltbld', 03:56:48 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518', 03:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:48 INFO - '_': '/tools/buildbot/bin/python'} 03:56:48 INFO - TEST-INFO | started process 13211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5D3mo3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:49 INFO - PID 13211 | 03:56:49 INFO - PID 13211 | (/builds/slave/test/build/application/firefox/firefox:13260): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:56:49 INFO - PID 13211 | 03:57:00 INFO - PID 13211 | RSS: Main: 153464832 03:57:00 INFO - PID 13211 | 03:57:02 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37300/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:03 INFO - PID 13211 | RSS: Main: 160706560 03:57:03 INFO - PID 13211 | 03:57:06 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37300/tests/kraken/driver.html?testName=audio-dft) 03:57:06 INFO - PID 13211 | RSS: Main: 160755712 03:57:06 INFO - PID 13211 | 03:57:09 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37300/tests/kraken/driver.html?testName=audio-fft) 03:57:10 INFO - PID 13211 | RSS: Main: 156307456 03:57:10 INFO - PID 13211 | 03:57:12 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37300/tests/kraken/driver.html?testName=audio-oscillator) 03:57:13 INFO - PID 13211 | RSS: Main: 156618752 03:57:13 INFO - PID 13211 | 03:57:15 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:15 INFO - PID 13211 | RSS: Main: 156774400 03:57:15 INFO - PID 13211 | 03:57:19 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37300/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:19 INFO - PID 13211 | RSS: Main: 159010816 03:57:19 INFO - PID 13211 | 03:57:23 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37300/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:23 INFO - PID 13211 | RSS: Main: 159600640 03:57:23 INFO - PID 13211 | 03:57:26 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37300/tests/kraken/driver.html?testName=json-parse-financial) 03:57:27 INFO - PID 13211 | RSS: Main: 159440896 03:57:27 INFO - PID 13211 | 03:57:29 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:29 INFO - PID 13211 | RSS: Main: 159326208 03:57:29 INFO - PID 13211 | 03:57:31 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:32 INFO - PID 13211 | RSS: Main: 159223808 03:57:32 INFO - PID 13211 | 03:57:34 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:34 INFO - PID 13211 | RSS: Main: 156381184 03:57:34 INFO - PID 13211 | 03:57:37 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:38 INFO - PID 13211 | RSS: Main: 156938240 03:57:38 INFO - PID 13211 | 03:57:41 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:41 INFO - PID 13211 | RSS: Main: 157016064 03:57:41 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | Cycle 1(1): loaded http://localhost:37300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37300/tests/kraken/driver.html?testName=ai-astar) 03:57:43 INFO - PID 13211 | RSS: Main: 158314496 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | __start_tp_report 03:57:43 INFO - PID 13211 | _x_x_mozilla_page_load 03:57:43 INFO - PID 13211 | _x_x_mozilla_page_load_details 03:57:43 INFO - PID 13211 | |i|pagename|runs| 03:57:43 INFO - PID 13211 | |0;ai-astar;108;107;107;107;106;95;107;106;107;107 03:57:43 INFO - PID 13211 | |1;audio-beat-detection;122;117;116;119;120;117;119;125;119;117 03:57:43 INFO - PID 13211 | |2;audio-dft;163;162;163;162;163;163;163;165;166;167 03:57:43 INFO - PID 13211 | |3;audio-fft;73;74;76;73;73;74;75;73;73;74 03:57:43 INFO - PID 13211 | |4;audio-oscillator;80;84;78;78;79;80;79;81;79;83 03:57:43 INFO - PID 13211 | |5;imaging-gaussian-blur;113;113;114;114;111;114;110;114;114;117 03:57:43 INFO - PID 13211 | |6;imaging-darkroom;157;149;148;151;148;148;148;148;149;154 03:57:43 INFO - PID 13211 | |7;imaging-desaturate;94;94;94;94;94;96;94;95;94;95 03:57:43 INFO - PID 13211 | |8;json-parse-financial;54;53;54;55;55;55;55;55;55;56 03:57:43 INFO - PID 13211 | |9;json-stringify-tinderbox;38;37;38;37;38;38;38;38;37;38 03:57:43 INFO - PID 13211 | |10;stanford-crypto-aes;76;77;76;73;79;72;75;76;77;75 03:57:43 INFO - PID 13211 | |11;stanford-crypto-ccm;118;119;110;119;128;115;123;114;113;116 03:57:43 INFO - PID 13211 | |12;stanford-crypto-pbkdf2;169;171;165;175;167;168;176;168;170;173 03:57:43 INFO - PID 13211 | |13;stanford-crypto-sha256-iterative;71;70;76;66;68;66;75;70;68;65 03:57:43 INFO - PID 13211 | __end_tp_report 03:57:43 INFO - PID 13211 | __start_cc_report 03:57:43 INFO - PID 13211 | _x_x_mozilla_cycle_collect,763 03:57:43 INFO - PID 13211 | __end_cc_report 03:57:43 INFO - PID 13211 | __startTimestamp1506164263703__endTimestamp 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | ------- Summary: start ------- 03:57:43 INFO - PID 13211 | Number of tests: 14 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#0] ai-astar Cycles:10 Average:105.70 Median:107.00 stddev:3.80 (3.6%) stddev-sans-first:3.94 03:57:43 INFO - PID 13211 | Values: 108.0 107.0 107.0 107.0 106.0 95.0 107.0 106.0 107.0 107.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:119.00 stddev:2.73 (2.3%) stddev-sans-first:2.68 03:57:43 INFO - PID 13211 | Values: 122.0 117.0 116.0 119.0 120.0 117.0 119.0 125.0 119.0 117.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:1.70 (1.0%) stddev-sans-first:1.79 03:57:43 INFO - PID 13211 | Values: 163.0 162.0 163.0 162.0 163.0 163.0 163.0 165.0 166.0 167.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 03:57:43 INFO - PID 13211 | Values: 73.0 74.0 76.0 73.0 73.0 74.0 75.0 73.0 73.0 74.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:80.00 stddev:2.02 (2.5%) stddev-sans-first:2.15 03:57:43 INFO - PID 13211 | Values: 80.0 84.0 78.0 78.0 79.0 80.0 79.0 81.0 79.0 83.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 03:57:43 INFO - PID 13211 | Values: 113.0 113.0 114.0 114.0 111.0 114.0 110.0 114.0 114.0 117.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:149.00 stddev:3.13 (2.1%) stddev-sans-first:2.05 03:57:43 INFO - PID 13211 | Values: 157.0 149.0 148.0 151.0 148.0 148.0 148.0 148.0 149.0 154.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:57:43 INFO - PID 13211 | Values: 94.0 94.0 94.0 94.0 94.0 96.0 94.0 95.0 94.0 95.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 03:57:43 INFO - PID 13211 | Values: 54.0 53.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 03:57:43 INFO - PID 13211 | Values: 38.0 37.0 38.0 37.0 38.0 38.0 38.0 38.0 37.0 38.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.00 stddev:2.01 (2.6%) stddev-sans-first:2.13 03:57:43 INFO - PID 13211 | Values: 76.0 77.0 76.0 73.0 79.0 72.0 75.0 76.0 77.0 75.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:118.50 stddev:5.19 (4.4%) stddev-sans-first:5.50 03:57:43 INFO - PID 13211 | Values: 118.0 119.0 110.0 119.0 128.0 115.0 123.0 114.0 113.0 116.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:3.55 (2.1%) stddev-sans-first:3.74 03:57:43 INFO - PID 13211 | Values: 169.0 171.0 165.0 175.0 167.0 168.0 176.0 168.0 170.0 173.0 03:57:43 INFO - PID 13211 | 03:57:43 INFO - PID 13211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:3.72 (5.3%) stddev-sans-first:3.91 03:57:43 INFO - PID 13211 | Values: 71.0 70.0 76.0 66.0 68.0 66.0 75.0 70.0 68.0 65.0 03:57:43 INFO - PID 13211 | -------- Summary: end -------- 03:57:43 INFO - PID 13211 | 03:57:44 INFO - PID 13211 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:57:44 INFO - TEST-INFO | 13211: exit 0 03:57:44 INFO - TEST-OK | kraken | took 60405ms 03:57:44 INFO - SUITE-END | took 1169s 03:57:44 INFO - Completed test suite (00:19:29) 03:57:44 INFO - javascript benchmark 03:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8492.573755620015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.95338069929, 3121.4069326827903, 3144.6855314468557, 3160.336329370832, 3168.841557922103, 6184.69076546172, 6299.77950771723, 6343.968280158599, 6365.777197798078, 6390.233172019352, 6259.029850373199, 6297.5276854236, 6314.116023756677, 6340.7463701452, 6470.838229044276, 5835.708214589275, 5894.410558944114, 5907.084401917709, 5914.88170236595, 5918.88162236755, 5714.200011998323, 5814.273215848019, 5862.2965244170755, 5893.793717219898, 5924.58527903047, 5850.736716847752, 5854.895637284022, 5887.970560147171, 5910.261217347832, 5940.524758019348, 5742.7415766290615, 5759.539236861041, 5797.304323481167, 5815.854603634901, 5865.85335366615, 5717.571182161313, 5765.394633563499, 5766.942330576724, 5806.564507661942, 5807.477327040544, 6263.592866463665, 6285.87428251437, 6292.056191571255, 6294.244690637107, 6361.3638636136475, 6609.272979972199, 6668.433183179435, 6710.698018589175, 6738.93261067388, 6826.897596536056, 6773.593584384904, 6791.422729068036, 6802.14973128359, 6850.623215723133, 6945.89581156283, 6334.398232167937, 6393.776217832354, 6410.166678331787, 6412.839679008015, 6418.06937993993, 6949.965250173716, 6969.128858892638, 6980.267071957473, 7044.859102818017, 7068.469864760164, 6479.254885688206, 6624.27133015368, 6650.70071846768, 6727.0, 6749.898751518731, 6728.562643428161, 6797.048413222153, 6855.211650660238, 6866.862662746817, 6874.828129296808, 6565.967170164118, 6670.633115178614, 6773.695183716744, 6787.762428314985, 6858.211305699809, 6726.529142960044, 6737.225219099866, 6743.190817101881, 6743.730250789913, 6746.932530674729, 5297.0, 5319.654222475604, 5332.0402327581405, 5388.568914486832, 5400.270963419966, 4704.3649107370065, 4745.786439610226, 4764.4282686077895, 4769.260764581495, 4795.064962332382, 5724.284464441945, 5839.591228613956, 5884.176215329857, 5894.764209431574, 5931.822045338647, 6636.236832764197, 6755.49333799967, 6781.525293229427, 6838.487113466411, 6875.931240687529, 5846.590738648339, 5862.824115276549, 5888.087346461305, 5891.882162356729, 5893.44012318829, 5800.477956983892, 5809.925163844618, 5839.328477225174, 5912.733926973297, 5916.26046744157, 6383.106365108889, 6498.187726534184, 6565.80302590923, 6637.070810086591, 6642.169728783902, 6780.084688566981, 6875.243723190545, 6878.3465570770695, 6883.27725588826, 6891.241963383924, 6542.869142617026, 6651.16860392451, 6667.666616669244, 6669.333066693292, 6672.466202703675, 6695.196576410667, 6698.732050718112, 6729.798106056826, 6792.320767923168, 6809.319068093151, 6750.966245168743, 6799.422049125879, 6827.89758153638, 6862.416694581017, 6867.21027081872, 6615.966920165369, 6629.46964242869, 6630.237522684953, 6634.0712300278965, 6656.400923916871, 6525.347465253437, 6526.184226971629, 6554.377334153248, 6556.18047744032, 6675.766348177791, 6458.418742313214, 6501.804945851632, 6526.118973938647, 6527.934720652733, 6533.314002029719, 6614.404703576702, 6651.73393064272, 6656.467482601477, 6670.699818508082, 6680.83297917556, 6345.460635846005, 6364.109024736633, 6367.267764207176, 6442.194725659293, 6443.323451037573], "value": 6185.598137443211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.5774597209447, 843.7426584891607, 869.0874581689225, 870.0820634230884, 871.0723079919885, 40700.59299407005, 41354.58645413549, 41442.79278603603, 41475.792621036926, 41547.58452415479, 37886.0, 40760.18479630406, 41444.792776036156, 41464.79267603665, 41558.16883662325, 7866.016747906526, 7989.720359787409, 8001.7199398021085, 8009.479383840061, 8010.239027292427, 7708.11356693979, 7774.65014074368, 7832.412569057315, 7886.842263154734, 7892.605369731519, 7766.57283849388, 7854.607269636524, 7855.960720196391, 7879.093904201033, 7886.171951945049, 7790.298873101419, 7792.610369481503, 7826.765197044069, 7836.843263134705, 7864.449488535804, 7741.729039483647, 7798.0, 7829.765107046797, 7849.097353804328, 7850.214978502161, 38167.236655267014, 38180.80909595434, 38457.230855383015, 38533.614663853565, 38542.61457385418, 3524.1189702574356, 3526.1713497328105, 3542.415501442259, 3552.928941421183, 3557.7331700122336, 31143.844280778678, 31202.219944501343, 31301.843490782627, 31324.0, 31357.0, 4960.87597810054, 5137.3064636274, 5184.585233181374, 5212.6611770235195, 5223.425423203483, 178927.0, 182152.0, 188241.0, 189318.0, 198567.0, 47779.5222047782, 47932.28101578479, 48261.75869120632, 48282.51717482851, 48355.0, 49662.75168624134, 49740.75129624329, 49851.75074124606, 49905.75047124814, 49944.25083623749, 15314.0, 15499.845001550066, 15536.844631553766, 15565.14391708467, 15965.882388232712, 13005.739885202243, 13039.152455090389, 13049.804252936214, 13062.54281100157, 13063.412146453433, 13338.266395348155, 13466.394012269471, 13491.527796527074, 13509.2569908654, 13641.795373069412, 5166.974165129225, 5220.919657402151, 5251.632385733038, 5348.277982472394, 5416.972915135478, 1013.2350075692805, 1014.0569270578433, 1026.343140390151, 1028.804527139841, 1044.6970378590277, 22519.32442026709, 22535.774642253367, 22638.320850374515, 22953.19663811792, 23031.0, 1117.4915413486844, 1119.630521927778, 1135.6593022093339, 1142.8400023996646, 1146.0201527693869, 11901.642950711492, 12030.338331391857, 12096.939515302367, 12116.15186936906, 12197.817032744517, 217121.0, 217290.0, 217715.0, 218106.0, 218578.0, 52207.477925220264, 52208.216876746876, 52242.21636675453, 52245.47754522482, 52344.47655523472, 1450.91294522329, 1463.3122432456728, 1464.1068947941747, 1468.2585294426246, 1472.7349077166214, 21681.0, 22293.10827566879, 22402.551948960605, 22622.208222712125, 22706.318810435714, 36993.81503092467, 37028.0, 37039.0, 37049.81475092715, 37056.814715926244, 185575.0, 185795.0, 186324.06837965723, 186696.0, 186802.06598966918, 33881.0, 34968.82515587406, 35652.7521536745, 35716.64283357237, 35729.1067723309, 45158.0, 45707.77146114248, 45830.54169458396, 45863.77068114638, 46060.07879842451, 32304.83847580747, 32465.35069298648, 32484.675153248165, 32782.0, 33042.0, 32431.0, 32781.672183277864, 32963.34073318568, 33119.337613248084, 33668.83165584156, 35907.64092359043, 36398.27203455969, 36787.08032299214, 36812.44781328336, 36866.0, 31570.842145789124, 31864.68135318617, 32369.35261294808, 32551.0, 32812.34375312528, 23853.403664908517, 23857.403564911016, 23891.40271493157, 23961.52076958486, 24020.759792401852], "value": 17099.0634879644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.6766144789643, 603.3001718007113, 605.3855336833112, 617.8702472480779, 638.6838514935108, 22022.779772202273, 22543.54912901741, 22548.3235502935, 22575.54848903021, 22625.547489050252, 22482.213122540714, 24368.634470482957, 24481.265562033168, 24485.755142448572, 24566.0, 6406.295307516181, 6600.834979125512, 6602.372774586406, 6603.9669801650925, 6611.801645950629, 6289.685515724218, 6503.544751867371, 6600.834979125536, 6605.306442823507, 6611.206655201383, 6496.707648155821, 6522.380373864476, 6523.739050437976, 6533.31400202979, 6533.738650453976, 6530.8040758777315, 6536.182977127859, 6539.247986481568, 6539.869202615945, 6542.509311801587, 5800.158976948319, 6013.879722405572, 6014.338422773535, 6022.638641681513, 6077.604955677867, 28329.716702832913, 28536.0, 28635.57046644302, 28638.284042898886, 28753.0, 1923.3460623387975, 1969.2123150739676, 1970.1725275384374, 1970.9901450492798, 1971.940841774749, 18858.811411885843, 19166.808331916644, 19595.706064409045, 19661.410157695293, 19975.101120449468, 2442.792362649177, 2469.5431345201014, 2474.938126546833, 2505.448801263719, 2512.886920088582, 121661.0, 126832.0, 133149.0, 136570.0, 143482.56517434795, 14769.704605907822, 14834.258287085602, 14903.368001239562, 14941.310564098567, 15073.623159421102, 22339.0, 22538.0, 22608.321750347517, 22612.30407719395, 22626.886865565568, 9513.096255855682, 9560.235181185488, 9698.70903872885, 9783.168430683472, 9866.753331166778, 8668.60991255395, 8674.262687671619, 8763.693270735494, 8775.210231079234, 8784.385093043553, 8977.955110224537, 9117.179453849185, 9120.817583648422, 9150.22223111043, 9169.40398874071, 2742.75315221631, 2796.5385711357803, 2800.6219160413084, 2804.6213761141985, 2875.2236896037953, 953.2802733935835, 966.3042609321277, 970.8496178835535, 973.6689525561343, 973.9659111931048, 18206.908965455354, 18633.627327453374, 18868.905655471634, 19096.90451547761, 19284.614307713768, 986.1312812220945, 1009.6062535611118, 1019.6940917724653, 1024.1806554756165, 1033.3180101133216, 10290.3825770454, 10415.479226038668, 10542.947285263677, 10555.736106597396, 10779.67660970172, 455036.0, 458974.0, 461208.0, 464426.0, 467649.0, 101618.0, 102476.0, 103553.96446035443, 103876.48061759795, 106830.0, 1123.9213255072066, 1139.2594813371209, 1157.4849192109598, 1159.60573405041, 1168.4449886304108, 16659.25033373477, 16679.49961501157, 16760.078195699352, 16933.230393743732, 17239.310427582757, 56116.43883561112, 56135.719321404766, 56788.71605641946, 57675.42324576868, 58338.249852504494, 66435.66782166252, 66640.0, 66860.6656966712, 67592.0, 67906.98139527813, 13706.931465343008, 13805.79291310611, 13854.30728463593, 13861.930690346888, 13966.0, 21021.789782101983, 21437.46406339854, 21624.89187554115, 21832.45418864541, 21867.890660546596, 17215.655686886443, 17340.653186936444, 17689.646207076043, 17694.557636059202, 17723.645527089127, 15412.152331621868, 15816.920915395349, 15968.0, 16161.4343497977, 16373.42693005739, 16763.49709508717, 17184.0, 17477.300907963538, 17890.28438862431, 17969.101544922964, 13717.17696938187, 13831.930840345734, 13934.721305574034, 13939.930300348433, 13963.092398994033, 17397.130143492523, 17587.472375828747, 17600.823991759917, 17675.46973590743, 17699.38052168168], "value": 11631.042385267097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.3739361197045, 1402.4179965314395, 1409.2178840743384, 1415.0731271017485, 1426.1728197645366, 14921.0, 15694.293756780944, 15707.371705131794, 15707.450239241629, 15776.368945242206, 15924.20378981052, 16262.75605865913, 16275.430359937405, 16282.348706051773, 16288.511344659679, 2809.8620058876086, 2863.6134121893488, 2865.5844902489125, 2865.856707164644, 2868.153894601098, 2716.5517689581197, 2793.092245020366, 2816.2818481287245, 2865.269356314137, 2866.082853486885, 2790.4419116176746, 2802.3134332088666, 2806.873690683914, 2814.8170368926058, 2817.3942602340494, 2747.917562473129, 2750.917472475829, 2774.389634280455, 2795.4269374778123, 2798.1325789005373, 2729.9454010919867, 2748.9037883674177, 2759.6274502942047, 2764.0, 2764.074035198211, 14879.18164500952, 15231.466898658493, 15270.38918443272, 15315.693686126215, 15358.692826143415, 8067.031956165239, 8239.876401853977, 8349.165083491664, 8349.41554091214, 8351.415400921938, 5218.269442278084, 5429.945700542983, 5498.230247765316, 5501.202325662796, 5511.944880551183, 1966.488712934633, 2002.2991952816544, 2028.523297025198, 2058.464799152216, 2074.2740040985686, 27787.444251114863, 28003.85998070017, 28064.719352806416, 28066.0, 28123.57814632782, 6842.178938527409, 6871.656417179221, 7120.857582848314, 7202.171750248788, 7317.451191160578, 18100.185491652643, 18109.7283540747, 18118.909405453152, 18120.63758724818, 18133.45599632013, 8122.944017277716, 8238.588070596446, 8285.295749861209, 8288.50268983863, 8292.12932642064, 7455.813604659818, 7621.733239336597, 7668.923310766932, 7684.3084122429245, 7685.154632990367, 4851.830185943475, 5302.496262855023, 5494.325703151672, 5511.063119269734, 5668.9716551417805, 1460.532629558531, 1585.8969167004109, 1602.9100211855816, 1634.5750104972792, 1649.4556796257207, 854.4061876995429, 866.1425189062783, 872.2760109109424, 884.1997991817416, 887.2857349833317, 7782.533048017137, 7935.285824275843, 8138.593070346577, 8142.51144931306, 8226.629801658939, 985.6008316631776, 1004.352192835617, 1005.4520286443906, 1006.8036732837173, 1007.2244371833793, 4184.769837658958, 4268.722533035405, 4324.740515569013, 4326.913461730748, 4348.152110338517, 21465.0, 21760.89119554392, 21902.23342183016, 22586.548269034854, 22664.660030099563, 20944.685829712565, 21493.78506214949, 22396.10415583391, 22580.322590322317, 22615.321540353816, 11506.137039722222, 11552.480138393792, 11645.708857278467, 11752.0, 11757.88242117585, 7801.1808760079375, 8048.557329346942, 8052.396070294869, 8089.312408445348, 8151.551664658264, 18046.909765451088, 18675.43973680792, 18756.718649219998, 18837.340693076225, 19139.13873875707, 19113.713294300876, 19190.8080919189, 19238.80761192426, 19513.512162196057, 19737.90131049393, 11266.7746645065, 11330.60342887995, 11445.48495317696, 11468.4265786712, 11469.254498457907, 12720.491180352683, 14184.716305673623, 14363.138211707332, 14364.640883977983, 14377.64055898611, 11533.365664888512, 11574.768504629692, 11775.587854425397, 11801.29192248468, 11942.223755455867, 11008.834867476835, 11155.888441115809, 11301.43492825339, 11317.490712918103, 11346.205765596329, 9225.86161207569, 9333.626654933998, 9335.953320233355, 9374.250059995047, 9433.151016408556, 6823.1812182538415, 6850.0, 6877.174739031148, 7011.228764835762, 7071.575705457689, 7298.23368546295, 7385.372243359375, 7387.963060184879, 7477.962610187132, 7588.0], "value": 6773.31330898854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.29278168056686, 531.6464551073536, 532.8658721819114, 535.9598030147739, 542.7828868452618, 6290.811275661732, 6305.653189074599, 6334.493240540757, 6361.4274715275615, 6362.268339141, 6122.499987503057, 6181.412765787243, 6206.379362063792, 6258.84352891178, 6318.147050148229, 5190.506901844319, 5219.321488206538, 5232.215167724834, 5244.816431424901, 5252.185911183773, 4893.094777466163, 5217.165253559431, 5220.1110172921035, 5221.590170653921, 5239.476052394768, 5029.497050294959, 5041.621878359119, 5044.772985215674, 5050.570701490377, 5052.646314757969, 5028.195488721805, 5029.145045342282, 5044.520770526794, 5047.738065483629, 5069.087564238435, 4542.114287713897, 4546.0, 4548.818047278105, 4556.225441674923, 4561.6806823522365, 6180.1347811306005, 6202.255729312466, 6217.285012223607, 6232.6288216592275, 6244.219472565929, 5795.159701843251, 5796.13058041293, 5796.710164491801, 5802.912956305659, 5812.534997200256, 6572.572782769153, 6595.670216489204, 6609.001554059772, 6637.137172167587, 6648.16897887764, 4916.680415772963, 4931.186354251544, 4942.851714448537, 4944.53026962438, 4945.9258111128365, 6604.438622717074, 6727.29363416844, 6816.386525212754, 6925.0, 6928.965355173243, 5031.647784655039, 5042.823501177441, 5048.16705243638, 5048.217526283432, 5052.166392545262, 5026.472220416877, 5078.669886457368, 5088.1350170471105, 5126.820561280338, 5130.230465430215, 5661.377248502661, 5665.5467562594895, 5683.488486036276, 5713.314402271754, 5760.913586296209, 6605.30644282353, 6628.4697224221945, 6651.567648102858, 6670.866582668416, 6694.828405029198, 1753.4126067767186, 1762.7444020617195, 1764.2413762082429, 1776.0, 1789.150153676993, 1171.5313874450287, 1221.2428294457493, 1225.4424236972156, 1229.2624425344723, 1260.4139075330015, 5615.742869135891, 5631.352394474606, 5644.238027866186, 5652.63257888236, 5758.12671075509, 6663.867142585772, 6681.198256209286, 6697.665116744143, 6754.966225168842, 6785.694643741043, 5613.775448982076, 5619.26949496571, 5619.831405057773, 5646.6047376684055, 5726.9713651431475, 3575.2313252650806, 3589.6230895756094, 3595.640435956436, 3613.457981302826, 3614.644508309384, 6442.613443193423, 6500.154979852589, 6520.250171230369, 6530.673466326664, 6534.0, 6469.838254043592, 6720.966395167993, 6840.931590684129, 6913.619750913748, 6945.826354341182, 6323.620582765049, 6326.620402775849, 6447.871042579122, 6492.740290388426, 6570.934290657128, 6605.636689981905, 6632.1709786276715, 6674.733010679518, 6690.397864192246, 6702.597844129368, 6667.53327267106, 6678.933210668026, 6687.933120668731, 6700.6984685688285, 6780.660966951731, 6490.578112422866, 6503.6097834130105, 6537.673116344069, 6554.705038273384, 6556.3443655634055, 5033.169527028, 5039.168537191323, 5041.395032596112, 5058.443571207091, 5064.594832413324, 6419.325970773189, 6615.37153970372, 6650.46796256308, 6812.625305608239, 6822.863542729018, 6276.874462510816, 6493.461063720379, 6500.349965003462, 6506.154199953976, 6563.9343606565235, 6462.159919210472, 6514.869702606016, 6538.057873956644, 6556.508261880283, 6573.516036500662, 6353.650549219838, 6376.458001069961, 6392.712327945346, 6415.262244841903, 6480.384363485461, 6519.771807986887, 6524.804255872332, 6584.736610535717, 6633.0, 6646.4350530205475, 6307.400796924285, 6344.382182543422, 6370.58591191571, 6387.105805187371, 6408.1349017881985], "value": 5084.747341048933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.3445519226154, 921.594498420695, 930.3115694386156, 947.7962238118803, 959.3045042344299, 19524.219031238732, 20479.078441470134, 20495.692564611523, 20510.487237819045, 20544.486387840312, 19077.236910523563, 19079.61840763184, 19298.4210473686, 19834.603307933834, 19848.80151198491, 962.2638681408728, 976.4727047394399, 977.8435450327949, 977.9315447918613, 978.0, 962.5283611030615, 999.4153420249163, 1004.1765752083259, 1004.9949750251238, 1005.316384858296, 1048.6487026846016, 1054.3357684658654, 1055.2613170780446, 1055.3456856748826, 1061.0821639282042, 1043.9895601043968, 1047.0628787235419, 1047.4343854318658, 1049.7533079726259, 1050.7058023753323, 725.8548290341953, 747.096013823269, 753.4311594745986, 753.5516367761173, 771.2133623703846, 20427.89786051075, 20663.690044649342, 20739.27412540569, 20914.37256882296, 20999.0, 21827.890860545755, 21925.890370548204, 22516.0, 22577.774222257733, 22701.31896043105, 17238.0, 17669.469915902544, 17705.55736106595, 17713.55716107095, 17718.0, 3520.1903562180587, 3539.50446937429, 3567.3222087803492, 3575.713942884563, 3576.088097535138, 135870.32064839613, 137528.0, 139173.0, 140286.0, 142182.0, 16467.34130634761, 16801.495955121365, 16852.24164912582, 16863.831361686225, 16892.91553542249, 30628.54057189144, 30877.8456107718, 31274.0, 31775.04674859758, 31964.0, 9247.26021918245, 9253.537323133816, 9316.114969077928, 9322.25421966241, 9329.673461428818, 4184.225918205142, 4191.098913733501, 4207.915841683211, 4223.68322375823, 4293.034067334825, 5463.399026107125, 5575.553955683536, 5593.300837395325, 5603.047481928082, 5609.887802243932, 966.1546147121269, 986.2849434160177, 1005.1606908231709, 1006.2201793610011, 1008.349614498659, 593.7239183779564, 599.3916175082295, 619.2723549828933, 623.9032949892683, 625.4902254662436, 10609.098226650822, 11284.560461188199, 11511.942440287745, 12053.457594408274, 12196.207246528948, 633.3191818794722, 641.3298103481873, 646.8997305417668, 649.1074772188241, 666.1872515531045, 5602.467765562265, 5631.014572449805, 5648.491635752802, 5654.37801841797, 5812.215350927655, 111092.0, 113384.0, 113472.0, 114764.0, 117427.0, 99210.0, 99834.5008274954, 100157.0, 100176.0, 100230.0, 86741.5662921694, 93120.53439732894, 93219.0, 93363.0, 94122.46979248484, 10318.896811031793, 10397.636082737068, 10450.738731531772, 10712.57149714034, 10779.407132607781, 43744.0, 44333.0, 44485.0, 44571.554284458034, 45786.54213457823, 53656.195157071896, 53830.0, 54685.0, 55282.170767439326, 55297.44702552923, 15287.770683439534, 15561.76657350118, 15682.0, 15718.76421853696, 15787.921060394625, 17348.913255433643, 17410.738838917172, 17480.47558573245, 17645.29418823284, 17659.0, 15494.922525387301, 15627.765583516484, 15751.44869929547, 15792.842071579596, 15892.125933073792, 15857.444989425314, 15944.0, 15971.44099956496, 16138.919305403399, 16166.838331616533, 14736.926315368783, 14746.262686865828, 14773.556793296219, 14923.104613723212, 14934.626634334229, 11260.549578016788, 11302.943485282522, 11464.713382165513, 11501.424928753697, 11698.181127321006, 11037.834432483358, 11098.61154859576, 11311.717207069889, 11315.0, 11358.772824543297], "value": 8854.58201930064, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 107.0, 106.0, 95.0, 107.0, 106.0, 107.0, 107.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 116.0, 119.0, 120.0, 117.0, 119.0, 125.0, 119.0, 117.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 163.0, 163.0, 163.0, 165.0, 166.0, 167.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 73.0, 73.0, 74.0, 75.0, 73.0, 73.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 78.0, 78.0, 79.0, 80.0, 79.0, 81.0, 79.0, 83.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 111.0, 114.0, 110.0, 114.0, 114.0, 117.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 148.0, 151.0, 148.0, 148.0, 148.0, 148.0, 149.0, 154.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 73.0, 79.0, 72.0, 75.0, 76.0, 77.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 110.0, 119.0, 128.0, 115.0, 123.0, 114.0, 113.0, 116.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 165.0, 175.0, 167.0, 168.0, 176.0, 168.0, 170.0, 173.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 76.0, 66.0, 68.0, 66.0, 75.0, 70.0, 68.0, 65.0], "value": 69.5, "unit": "score"}]}]} 03:57:44 INFO - Return code: 0 03:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:44 INFO - # TBPL SUCCESS # 03:57:44 INFO - Running post-action listener: _package_coverage_data 03:57:44 INFO - Running post-action listener: _resource_record_post_action 03:57:44 INFO - [mozharness: 2017-09-23 10:57:44.487699Z] Finished run-tests step (success) 03:57:44 INFO - Running post-run listener: _resource_record_post_run 03:57:44 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346333184; Read time: 16; Write time: 190092 03:57:44 INFO - TinderboxPrint: CPU usage
13.1% 03:57:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:57:44 INFO - TinderboxPrint: I/O write bytes / time
346,333,184 / 190,092 03:57:44 INFO - TinderboxPrint: CPU idle
8,223.2 (86.9%) 03:57:44 INFO - TinderboxPrint: CPU user
1,192.7 (12.6%) 03:57:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9920512; Read time: 0; Write time: 752 03:57:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:57:44 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 336408576; Read time: 0; Write time: 189316 03:57:45 INFO - Running post-run listener: _upload_blobber_files 03:57:45 INFO - Blob upload gear active. 03:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:46 INFO - (blobuploader) - INFO - Done attempting. 03:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:53 INFO - (blobuploader) - INFO - Done attempting. 03:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:54 INFO - (blobuploader) - INFO - Done attempting. 03:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:55 INFO - (blobuploader) - INFO - Done attempting. 03:57:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:55 INFO - Return code: 0 03:57:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cefe8323588d8a3e0fee7c8fd5f2ca7bc74424d0c6cfa5b29bcd04305ce78e88e789f09b76f690ab597ba4cef3b5791b76debc08d7fa7c9c3d4fde9495bbac9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a098d2fe325d794cb68368a8ee5f782114614d78afa034006f04faf37b5aa3a4cc15ac8d7791332e47e4f218c23e4216f807d9da65ead15517bb4908d1e39cb8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8349aa67f735f0c47b68df46a20215482aacadb76348abdd6b5fcd2ac375cffbc2423fcb63374a097b14199abe533a7fe57954965be1ced1a9793a8a0d950fc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72958b7fd4d801d6102ac488d1188796adbecc16956b520835d7efe2d6d5cef7e9bfa7f760325f750d41f84a09913b73cfe05c84ac913a74715909397ee52906"} 03:57:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:55 INFO - Contents: 03:57:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cefe8323588d8a3e0fee7c8fd5f2ca7bc74424d0c6cfa5b29bcd04305ce78e88e789f09b76f690ab597ba4cef3b5791b76debc08d7fa7c9c3d4fde9495bbac9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a098d2fe325d794cb68368a8ee5f782114614d78afa034006f04faf37b5aa3a4cc15ac8d7791332e47e4f218c23e4216f807d9da65ead15517bb4908d1e39cb8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8349aa67f735f0c47b68df46a20215482aacadb76348abdd6b5fcd2ac375cffbc2423fcb63374a097b14199abe533a7fe57954965be1ced1a9793a8a0d950fc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72958b7fd4d801d6102ac488d1188796adbecc16956b520835d7efe2d6d5cef7e9bfa7f760325f750d41f84a09913b73cfe05c84ac913a74715909397ee52906"} 03:57:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:55 INFO - Copying logs to upload dir... 03:57:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.381272 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-23 03:57:55.897338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:55.898487) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cefe8323588d8a3e0fee7c8fd5f2ca7bc74424d0c6cfa5b29bcd04305ce78e88e789f09b76f690ab597ba4cef3b5791b76debc08d7fa7c9c3d4fde9495bbac9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a098d2fe325d794cb68368a8ee5f782114614d78afa034006f04faf37b5aa3a4cc15ac8d7791332e47e4f218c23e4216f807d9da65ead15517bb4908d1e39cb8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8349aa67f735f0c47b68df46a20215482aacadb76348abdd6b5fcd2ac375cffbc2423fcb63374a097b14199abe533a7fe57954965be1ced1a9793a8a0d950fc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72958b7fd4d801d6102ac488d1188796adbecc16956b520835d7efe2d6d5cef7e9bfa7f760325f750d41f84a09913b73cfe05c84ac913a74715909397ee52906"} build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cefe8323588d8a3e0fee7c8fd5f2ca7bc74424d0c6cfa5b29bcd04305ce78e88e789f09b76f690ab597ba4cef3b5791b76debc08d7fa7c9c3d4fde9495bbac9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a098d2fe325d794cb68368a8ee5f782114614d78afa034006f04faf37b5aa3a4cc15ac8d7791332e47e4f218c23e4216f807d9da65ead15517bb4908d1e39cb8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8349aa67f735f0c47b68df46a20215482aacadb76348abdd6b5fcd2ac375cffbc2423fcb63374a097b14199abe533a7fe57954965be1ced1a9793a8a0d950fc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72958b7fd4d801d6102ac488d1188796adbecc16956b520835d7efe2d6d5cef7e9bfa7f760325f750d41f84a09913b73cfe05c84ac913a74715909397ee52906"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:55.931104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:55.937503) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506163032.921581-1440208518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:55.987127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 03:57:55.987429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 03:57:55.987763) ========= ========= Total master_lag: 0.29 =========