builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-053 starttime: 1506163294.18 results: success (0) revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.176432) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.176923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.177208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.195007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.195389) ========= 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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 03:41:34-- 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% 54.5M=0s 2017-09-23 03:41:34 (54.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.363133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.578588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.578996) ========= 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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:34.629068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-23 03:41:34.629404) ========= 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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 03:41:34,678 truncating revision to first 12 chars 2017-09-23 03:41:34,678 Setting DEBUG logging. 2017-09-23 03:41:34,678 attempt 1/10 2017-09-23 03:41:34,679 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:41:36,017 unpacking tar archive at: mozilla-central-8db0c4ecd94c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.628185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-23 03:41:36.276934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:36.277261) ========= script_repo_revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:36.277628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:36.277885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:41:36.292803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 03:41:36.293206) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:36 INFO - MultiFileLogger online at 20170923 03:41:36 in /builds/slave/test 03:41:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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:41:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:36 INFO - {'append_to_log': False, 03:41:36 INFO - 'base_work_dir': '/builds/slave/test', 03:41:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:41:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:36 INFO - 'branch': 'Firefox-Non-PGO', 03:41:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:36 INFO - 'code_coverage': False, 03:41:36 INFO - 'config_files': ('talos/linux_config.py',), 03:41:36 INFO - 'default_actions': ('clobber', 03:41:36 INFO - 'read-buildbot-config', 03:41:36 INFO - 'download-and-extract', 03:41:36 INFO - 'populate-webroot', 03:41:36 INFO - 'create-virtualenv', 03:41:36 INFO - 'install', 03:41:36 INFO - 'setup-mitmproxy', 03:41:36 INFO - 'run-tests'), 03:41:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:36 INFO - 'disable_ccov_upload': False, 03:41:36 INFO - 'disable_stylo': False, 03:41:36 INFO - 'download_minidump_stackwalk': True, 03:41:36 INFO - 'download_symbols': 'ondemand', 03:41:36 INFO - 'enable_stylo': False, 03:41:36 INFO - 'enable_webrender': False, 03:41:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:41:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:36 INFO - 'gecko_profile': False, 03:41:36 INFO - 'gecko_profile_interval': 0, 03:41:36 INFO - 'installer_path': 'installer.exe', 03:41:36 INFO - 'log_level': 'info', 03:41:36 INFO - 'log_name': 'talos', 03:41:36 INFO - 'log_to_console': True, 03:41:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:36 INFO - 'opt_config_files': (), 03:41:36 INFO - 'pip_index': False, 03:41:36 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:41:36 INFO - 'system_bits': '32', 03:41:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:36 INFO - 'title': 'talos-linux64-ix-053', 03:41:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:36 INFO - 'use_talos_json': True, 03:41:36 INFO - 'verify': 'False', 03:41:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:36 INFO - 'work_dir': 'build'} 03:41:36 INFO - [mozharness: 2017-09-23 10:41:36.485675Z] Running clobber step. 03:41:36 INFO - Running pre-action listener: _resource_record_pre_action 03:41:36 INFO - Running main action method: clobber 03:41:36 INFO - rmtree: /builds/slave/test/build 03:41:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:37 INFO - Running post-action listener: _resource_record_post_action 03:41:37 INFO - [mozharness: 2017-09-23 10:41:37.483466Z] Finished clobber step (success) 03:41:37 INFO - [mozharness: 2017-09-23 10:41:37.483565Z] Running read-buildbot-config step. 03:41:37 INFO - Running pre-action listener: _resource_record_pre_action 03:41:37 INFO - Running main action method: read_buildbot_config 03:41:37 INFO - Using buildbot properties: 03:41:37 INFO - { 03:41:37 INFO - "project": "", 03:41:37 INFO - "product": "firefox", 03:41:37 INFO - "who": "archaeopteryx@coole-files.de", 03:41:37 INFO - "installer_path": "public/build/target.tar.bz2", 03:41:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:41:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:41:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:41:37 INFO - "stage_platform": "linux64", 03:41:37 INFO - "basedir": "/builds/slave/test", 03:41:37 INFO - "buildnumber": 62, 03:41:37 INFO - "platform": "ubuntu64_hw", 03:41:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:41:37 INFO - "slavebuilddir": "test", 03:41:37 INFO - "taskId": "Ef8lGysCS_WURW4S2wL1zQ", 03:41:37 INFO - "branch": "mozilla-central", 03:41:37 INFO - "script_repo_revision": "production", 03:41:37 INFO - "revision": "8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e", 03:41:37 INFO - "slavename": "talos-linux64-ix-053", 03:41:37 INFO - "repo_path": "mozilla-central" 03:41:37 INFO - } 03:41:37 INFO - Finding installer, test and symbols from parent task. 03:41:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ef8lGysCS_WURW4S2wL1zQ'}, attempt #1 03:41:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ef8lGysCS_WURW4S2wL1zQ'}, attempt #1 03:41:38 INFO - Task dependencies: G4ULSq9NTWSDYYmNphUW3A 03:41:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A'}, attempt #1 03:41:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:41:38 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:41:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip 03:41:38 INFO - Running post-action listener: _resource_record_post_action 03:41:38 INFO - [mozharness: 2017-09-23 10:41:38.858321Z] Finished read-buildbot-config step (success) 03:41:38 INFO - [mozharness: 2017-09-23 10:41:38.858541Z] Running download-and-extract step. 03:41:38 INFO - Running pre-action listener: _resource_record_pre_action 03:41:38 INFO - Running main action method: download_and_extract 03:41:38 INFO - mkdir: /builds/slave/test/build/tests 03:41: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:41:38 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:41:38 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:41:38 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:41:39 INFO - Downloaded 989 bytes. 03:41:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:41:39 INFO - Using the following test package requirements: 03:41:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:41:39 INFO - u'common': [u'target.common.tests.zip'], 03:41:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:41:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:41:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:41:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:41:39 INFO - u'mozbase': [u'target.common.tests.zip'], 03:41:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:41:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:41:39 INFO - u'web-platform': [u'target.common.tests.zip', 03:41:39 INFO - u'target.web-platform.tests.tar.gz'], 03:41:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:41:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:41:39 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:41:39 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:41:39 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip into memory 03:41:40 INFO - Content-Length response header: 54943895 03:41:40 INFO - Bytes received: 54943895 03:41:51 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:41:51 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:41:51 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip into memory 03:41:52 INFO - Content-Length response header: 14513823 03:41:52 INFO - Bytes received: 14513823 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:52 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:41:52 INFO - Downloading https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:41:52 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:41:53 INFO - Downloaded 61675129 bytes. 03:41:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:41:53 INFO - mkdir: /builds/slave/test/properties 03:41:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:53 INFO - Contents: 03:41:53 INFO - build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - Running post-action listener: find_tests_for_verification 03:41:53 INFO - Running post-action listener: set_extra_try_arguments 03:41:53 INFO - [mozharness: 2017-09-23 10:41:53.498947Z] Finished download-and-extract step (success) 03:41:53 INFO - [mozharness: 2017-09-23 10:41:53.499045Z] Running populate-webroot step. 03:41:53 INFO - Running pre-action listener: _resource_record_pre_action 03:41:53 INFO - Running main action method: populate_webroot 03:41:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tresize', 03:41:53 INFO - 'tcanvasmark']}, 03:41:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['dromaeo_css', 03:41:53 INFO - 'kraken']}, 03:41:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['damp', 'tps']}, 03:41:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['damp', 'tps']}, 03:41:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['dromaeo_dom']}, 03:41:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:41:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['basic_compositor_video', 03:41:53 INFO - 'glvideo']}, 03:41:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:41:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['ts_paint_webext', 03:41:53 INFO - 'tp5o_webext']}, 03:41:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:53 INFO - 'ts_paint', 03:41:53 INFO - 'tpaint', 03:41:53 INFO - 'sessionrestore', 03:41:53 INFO - 'sessionrestore_many_windows', 03:41:53 INFO - 'sessionrestore_no_auto_restore', 03:41:53 INFO - 'tabpaint']}, 03:41:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['a11yr', 03:41:53 INFO - 'ts_paint', 03:41:53 INFO - 'tpaint', 03:41:53 INFO - 'sessionrestore', 03:41:53 INFO - 'sessionrestore_many_windows', 03:41:53 INFO - 'sessionrestore_no_auto_restore', 03:41:53 INFO - 'tabpaint']}, 03:41:53 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:41:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:41:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['perf_reftest_singletons']}, 03:41:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['perf_reftest']}, 03:41:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:53 INFO - 'tsvgr_opacity', 03:41:53 INFO - 'tart', 03:41:53 INFO - 'tscrollx', 03:41:53 INFO - 'tsvg_static']}, 03:41:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tsvgx', 03:41:53 INFO - 'tsvgr_opacity', 03:41:53 INFO - 'tart', 03:41:53 INFO - 'tscrollx', 03:41:53 INFO - 'tsvg_static']}, 03:41:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:41:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tp5o']}, 03:41:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--disable-stylo', 03:41:53 INFO - '--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--stylo-threads=1', 03:41:53 INFO - '--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--xperf_path', 03:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:53 INFO - 'tests': ['tp5n']}, 03:41:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo', 03:41:53 INFO - '--xperf_path', 03:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:53 INFO - 'tests': ['tp5n']}}} 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - [mozharness: 2017-09-23 10:41:53.514490Z] Finished populate-webroot step (success) 03:41:53 INFO - [mozharness: 2017-09-23 10:41:53.514580Z] Running create-virtualenv step. 03:41:53 INFO - Running pre-action listener: _resource_record_pre_action 03:41:53 INFO - Running main action method: create_virtualenv 03:41:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:41:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:41:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:41:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:54 INFO - Installing pip...............done. 03:41:54 INFO - Return code: 0 03:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:41:54 INFO - Reading from file tmpfile_stdout 03:41:54 INFO - Output received: 03:41:54 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:41:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:54 INFO - Using env: {'DISPLAY': ':0', 03:41:54 INFO - 'HOME': '/home/cltbld', 03:41:54 INFO - 'LANG': 'en_US.UTF-8', 03:41:54 INFO - 'LANGUAGE': 'en_US:en', 03:41:54 INFO - 'LOGNAME': 'cltbld', 03:41:54 INFO - 'MAIL': '/var/mail/cltbld', 03:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:54 INFO - 'MOZ_NO_REMOTE': '1', 03:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:54 INFO - 'NO_EM_RESTART': '1', 03:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:54 INFO - 'PWD': '/builds/slave/test', 03:41:54 INFO - 'SHELL': '/bin/bash', 03:41:54 INFO - 'SHLVL': '1', 03:41:54 INFO - 'TERM': 'linux', 03:41:54 INFO - 'TMOUT': '86400', 03:41:54 INFO - 'USER': 'cltbld', 03:41:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:54 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:41:55 INFO - Downloading/unpacking pip>=1.5 03:41:55 INFO - Running setup.py egg_info for package pip 03:41:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:41:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:41:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:41:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:41:55 INFO - Installing collected packages: pip 03:41:55 INFO - Found existing installation: pip 1.1 03:41:55 INFO - Uninstalling pip: 03:41:55 INFO - Successfully uninstalled pip 03:41:55 INFO - Running setup.py install for pip 03:41:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:41:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:41:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:41:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:41:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Successfully installed pip 03:41:55 INFO - Cleaning up... 03:41:55 INFO - Return code: 0 03:41:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:41:55 INFO - Using env: {'DISPLAY': ':0', 03:41:55 INFO - 'HOME': '/home/cltbld', 03:41:55 INFO - 'LANG': 'en_US.UTF-8', 03:41:55 INFO - 'LANGUAGE': 'en_US:en', 03:41:55 INFO - 'LOGNAME': 'cltbld', 03:41:55 INFO - 'MAIL': '/var/mail/cltbld', 03:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:55 INFO - 'MOZ_NO_REMOTE': '1', 03:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:55 INFO - 'NO_EM_RESTART': '1', 03:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:55 INFO - 'PWD': '/builds/slave/test', 03:41:55 INFO - 'SHELL': '/bin/bash', 03:41:55 INFO - 'SHLVL': '1', 03:41:55 INFO - 'TERM': 'linux', 03:41:55 INFO - 'TMOUT': '86400', 03:41:55 INFO - 'USER': 'cltbld', 03:41:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:55 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:55 INFO - Downloading/unpacking psutil>=3.1.1 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:57 INFO - Installing collected packages: psutil 03:41:57 INFO - Running setup.py install for psutil 03:41:57 INFO - building 'psutil._psutil_linux' extension 03:41:57 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:41:57 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:41:57 INFO - building 'psutil._psutil_posix' extension 03:41:57 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:41:57 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:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:57 INFO - Successfully installed psutil 03:41:57 INFO - Cleaning up... 03:41:57 INFO - Return code: 0 03:41:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:41:57 INFO - Using env: {'DISPLAY': ':0', 03:41:57 INFO - 'HOME': '/home/cltbld', 03:41:57 INFO - 'LANG': 'en_US.UTF-8', 03:41:57 INFO - 'LANGUAGE': 'en_US:en', 03:41:57 INFO - 'LOGNAME': 'cltbld', 03:41:57 INFO - 'MAIL': '/var/mail/cltbld', 03:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:57 INFO - 'MOZ_NO_REMOTE': '1', 03:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:57 INFO - 'NO_EM_RESTART': '1', 03:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:57 INFO - 'PWD': '/builds/slave/test', 03:41:57 INFO - 'SHELL': '/bin/bash', 03:41:57 INFO - 'SHLVL': '1', 03:41:57 INFO - 'TERM': 'linux', 03:41:57 INFO - 'TMOUT': '86400', 03:41:57 INFO - 'USER': 'cltbld', 03:41:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:57 INFO - '_': '/tools/buildbot/bin/python'} 03:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:59 INFO - Installing collected packages: mozsystemmonitor 03:41:59 INFO - Running setup.py install for mozsystemmonitor 03:41:59 INFO - Successfully installed mozsystemmonitor 03:41:59 INFO - Cleaning up... 03:41:59 INFO - Return code: 0 03:41:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:41:59 INFO - Using env: {'DISPLAY': ':0', 03:41:59 INFO - 'HOME': '/home/cltbld', 03:41:59 INFO - 'LANG': 'en_US.UTF-8', 03:41:59 INFO - 'LANGUAGE': 'en_US:en', 03:41:59 INFO - 'LOGNAME': 'cltbld', 03:41:59 INFO - 'MAIL': '/var/mail/cltbld', 03:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:59 INFO - 'MOZ_NO_REMOTE': '1', 03:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:59 INFO - 'NO_EM_RESTART': '1', 03:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:59 INFO - 'PWD': '/builds/slave/test', 03:41:59 INFO - 'SHELL': '/bin/bash', 03:41:59 INFO - 'SHLVL': '1', 03:41:59 INFO - 'TERM': 'linux', 03:41:59 INFO - 'TMOUT': '86400', 03:41:59 INFO - 'USER': 'cltbld', 03:41:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:59 INFO - '_': '/tools/buildbot/bin/python'} 03:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:01 INFO - warning: no files found matching '*.txt' 03:42:01 INFO - no previously-included directories found matching 'build' 03:42:01 INFO - no previously-included directories found matching 'dist' 03:42:01 INFO - no previously-included directories found matching '.git*' 03:42:01 INFO - Installing collected packages: jsonschema, functools32 03:42:01 INFO - Running setup.py install for functools32 03:42:01 INFO - warning: no files found matching '*.txt' 03:42:01 INFO - no previously-included directories found matching 'build' 03:42:01 INFO - no previously-included directories found matching 'dist' 03:42:01 INFO - no previously-included directories found matching '.git*' 03:42:01 INFO - Successfully installed jsonschema functools32 03:42:01 INFO - Cleaning up... 03:42:01 INFO - Return code: 0 03:42:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:01 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:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:01 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:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:01 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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:01 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:42:01 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:42:01 INFO - Using env: {'DISPLAY': ':0', 03:42:01 INFO - 'HOME': '/home/cltbld', 03:42:01 INFO - 'LANG': 'en_US.UTF-8', 03:42:01 INFO - 'LANGUAGE': 'en_US:en', 03:42:01 INFO - 'LOGNAME': 'cltbld', 03:42:01 INFO - 'MAIL': '/var/mail/cltbld', 03:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:01 INFO - 'MOZ_NO_REMOTE': '1', 03:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:01 INFO - 'NO_EM_RESTART': '1', 03:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:01 INFO - 'PWD': '/builds/slave/test', 03:42:01 INFO - 'SHELL': '/bin/bash', 03:42:01 INFO - 'SHLVL': '1', 03:42:01 INFO - 'TERM': 'linux', 03:42:01 INFO - 'TMOUT': '86400', 03:42:01 INFO - 'USER': 'cltbld', 03:42:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:01 INFO - '_': '/tools/buildbot/bin/python'} 03:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:02 INFO - Cleaning up... 03:42:02 INFO - Return code: 0 03:42:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:42:02 INFO - Using env: {'DISPLAY': ':0', 03:42:02 INFO - 'HOME': '/home/cltbld', 03:42:02 INFO - 'LANG': 'en_US.UTF-8', 03:42:02 INFO - 'LANGUAGE': 'en_US:en', 03:42:02 INFO - 'LOGNAME': 'cltbld', 03:42:02 INFO - 'MAIL': '/var/mail/cltbld', 03:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:02 INFO - 'MOZ_NO_REMOTE': '1', 03:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:02 INFO - 'NO_EM_RESTART': '1', 03:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:02 INFO - 'PWD': '/builds/slave/test', 03:42:02 INFO - 'SHELL': '/bin/bash', 03:42:02 INFO - 'SHLVL': '1', 03:42:02 INFO - 'TERM': 'linux', 03:42:02 INFO - 'TMOUT': '86400', 03:42:02 INFO - 'USER': 'cltbld', 03:42:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:02 INFO - '_': '/tools/buildbot/bin/python'} 03:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:03 INFO - Downloading docopt-0.6.1.tar.gz 03:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:03 INFO - Running setup.py install for blobuploader 03:42:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:04 INFO - Running setup.py install for requests 03:42:04 INFO - Running setup.py install for docopt 03:42:04 INFO - Successfully installed blobuploader requests docopt 03:42:04 INFO - Cleaning up... 03:42:04 INFO - Return code: 0 03:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:04 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:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:04 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:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:04 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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:04 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:42:04 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:42:04 INFO - Using env: {'DISPLAY': ':0', 03:42:04 INFO - 'HOME': '/home/cltbld', 03:42:04 INFO - 'LANG': 'en_US.UTF-8', 03:42:04 INFO - 'LANGUAGE': 'en_US:en', 03:42:04 INFO - 'LOGNAME': 'cltbld', 03:42:04 INFO - 'MAIL': '/var/mail/cltbld', 03:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:04 INFO - 'MOZ_NO_REMOTE': '1', 03:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:04 INFO - 'NO_EM_RESTART': '1', 03:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:04 INFO - 'PWD': '/builds/slave/test', 03:42:04 INFO - 'SHELL': '/bin/bash', 03:42:04 INFO - 'SHLVL': '1', 03:42:04 INFO - 'TERM': 'linux', 03:42:04 INFO - 'TMOUT': '86400', 03:42:04 INFO - 'USER': 'cltbld', 03:42:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:04 INFO - '_': '/tools/buildbot/bin/python'} 03:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:04 INFO - Running setup.py (path:/tmp/pip-GAKf01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:04 INFO - Running setup.py (path:/tmp/pip-xRM1qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:04 INFO - Running setup.py (path:/tmp/pip-f5dE_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:04 INFO - Running setup.py (path:/tmp/pip-YKrGcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:05 INFO - Running setup.py (path:/tmp/pip-4SeHh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:05 INFO - Running setup.py (path:/tmp/pip-_3Ox5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:05 INFO - Running setup.py (path:/tmp/pip-Ukrfc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:05 INFO - Running setup.py (path:/tmp/pip-vpYfhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:05 INFO - Running setup.py (path:/tmp/pip-yugTI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:05 INFO - Running setup.py (path:/tmp/pip-5mkvBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:05 INFO - Running setup.py (path:/tmp/pip-0ElQ59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:05 INFO - Running setup.py (path:/tmp/pip-WGxOdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:05 INFO - Running setup.py (path:/tmp/pip-5u2n6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:05 INFO - Running setup.py (path:/tmp/pip-TLB7zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:05 INFO - Running setup.py (path:/tmp/pip-NM4np4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:05 INFO - Running setup.py (path:/tmp/pip-p2Mm3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:05 INFO - Running setup.py (path:/tmp/pip-73scqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:05 INFO - Running setup.py install for manifestparser 03:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for mozcrash 03:42:06 INFO - Running setup.py install for mozdebug 03:42:06 INFO - Running setup.py install for mozdevice 03:42:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for mozfile 03:42:06 INFO - Running setup.py install for mozhttpd 03:42:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for mozinfo 03:42:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for mozInstall 03:42:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for mozleak 03:42:06 INFO - Running setup.py install for mozlog 03:42:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:06 INFO - Running setup.py install for moznetwork 03:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozprocess 03:42:07 INFO - Running setup.py install for mozprofile 03:42:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozrunner 03:42:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozscreenshot 03:42:07 INFO - Running setup.py install for moztest 03:42:07 INFO - Running setup.py install for mozversion 03:42:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:07 INFO - Cleaning up... 03:42:07 INFO - Return code: 0 03:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:07 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:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:07 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:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:07 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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:07 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:42:07 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:42:07 INFO - Using env: {'DISPLAY': ':0', 03:42:07 INFO - 'HOME': '/home/cltbld', 03:42:07 INFO - 'LANG': 'en_US.UTF-8', 03:42:07 INFO - 'LANGUAGE': 'en_US:en', 03:42:07 INFO - 'LOGNAME': 'cltbld', 03:42:07 INFO - 'MAIL': '/var/mail/cltbld', 03:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:07 INFO - 'MOZ_NO_REMOTE': '1', 03:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:07 INFO - 'NO_EM_RESTART': '1', 03:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:07 INFO - 'PWD': '/builds/slave/test', 03:42:07 INFO - 'SHELL': '/bin/bash', 03:42:07 INFO - 'SHLVL': '1', 03:42:07 INFO - 'TERM': 'linux', 03:42:07 INFO - 'TMOUT': '86400', 03:42:07 INFO - 'USER': 'cltbld', 03:42:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:07 INFO - '_': '/tools/buildbot/bin/python'} 03:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:07 INFO - Running setup.py (path:/tmp/pip-Ko8rUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:08 INFO - Running setup.py (path:/tmp/pip-8DbYeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:08 INFO - Running setup.py (path:/tmp/pip-mu0Dgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:08 INFO - Running setup.py (path:/tmp/pip-4clo9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:08 INFO - Running setup.py (path:/tmp/pip-pmh_Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:08 INFO - Running setup.py (path:/tmp/pip-wQ90Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:08 INFO - Running setup.py (path:/tmp/pip-3pDM5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:08 INFO - Running setup.py (path:/tmp/pip-v_CMdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:08 INFO - Running setup.py (path:/tmp/pip-A5YGAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:08 INFO - Running setup.py (path:/tmp/pip-zFGgk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:08 INFO - Running setup.py (path:/tmp/pip-TZiMMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:08 INFO - Running setup.py (path:/tmp/pip-yTBYF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:08 INFO - Running setup.py (path:/tmp/pip-YdrCw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:08 INFO - Running setup.py (path:/tmp/pip-_QX7vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:08 INFO - Running setup.py (path:/tmp/pip-ap5jgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:08 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:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:09 INFO - Running setup.py (path:/tmp/pip-P58_zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:09 INFO - Running setup.py (path:/tmp/pip-sgxF32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:09 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:42:09 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:42:09 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:42:09 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:42:10 INFO - Downloading blessings-1.6.tar.gz 03:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:10 INFO - Installing collected packages: blessings 03:42:10 INFO - Running setup.py install for blessings 03:42:10 INFO - Successfully installed blessings 03:42:10 INFO - Cleaning up... 03:42:10 INFO - Return code: 0 03:42:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:10 INFO - Reading from file tmpfile_stdout 03:42:10 INFO - Current package versions: 03:42:10 INFO - argparse == 1.2.1 03:42:10 INFO - blessings == 1.6 03:42:10 INFO - blobuploader == 1.2.4 03:42:10 INFO - docopt == 0.6.1 03:42:10 INFO - functools32 == 3.2.3-2 03:42:10 INFO - jsonschema == 2.5.1 03:42:10 INFO - manifestparser == 1.1 03:42:10 INFO - mozInstall == 1.13 03:42:10 INFO - mozcrash == 1.0 03:42:10 INFO - mozdebug == 0.1 03:42:10 INFO - mozdevice == 0.51 03:42:10 INFO - mozfile == 1.2 03:42:10 INFO - mozhttpd == 0.7 03:42:10 INFO - mozinfo == 0.10 03:42:10 INFO - mozleak == 0.1 03:42:10 INFO - mozlog == 3.5 03:42:10 INFO - moznetwork == 0.27 03:42:10 INFO - mozprocess == 0.25 03:42:10 INFO - mozprofile == 0.28 03:42:10 INFO - mozrunner == 6.13 03:42:10 INFO - mozscreenshot == 0.1 03:42:10 INFO - mozsystemmonitor == 0.3 03:42:10 INFO - moztest == 0.8 03:42:10 INFO - mozversion == 1.4 03:42:10 INFO - psutil == 3.1.1 03:42:10 INFO - requests == 1.2.3 03:42:10 INFO - wsgiref == 0.1.2 03:42:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:10 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 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:10 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:42:10 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:42:10 INFO - Using env: {'DISPLAY': ':0', 03:42:10 INFO - 'HOME': '/home/cltbld', 03:42:10 INFO - 'LANG': 'en_US.UTF-8', 03:42:10 INFO - 'LANGUAGE': 'en_US:en', 03:42:10 INFO - 'LOGNAME': 'cltbld', 03:42:10 INFO - 'MAIL': '/var/mail/cltbld', 03:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:10 INFO - 'MOZ_NO_REMOTE': '1', 03:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:10 INFO - 'NO_EM_RESTART': '1', 03:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:10 INFO - 'PWD': '/builds/slave/test', 03:42:10 INFO - 'SHELL': '/bin/bash', 03:42:10 INFO - 'SHLVL': '1', 03:42:10 INFO - 'TERM': 'linux', 03:42:10 INFO - 'TMOUT': '86400', 03:42:10 INFO - 'USER': 'cltbld', 03:42:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:10 INFO - '_': '/tools/buildbot/bin/python'} 03:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:42:10 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:42:10 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:42:10 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:42:10 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:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:42:12 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:42:12 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:42:12 INFO - Installing collected packages: simplejson 03:42:12 INFO - Running setup.py install for simplejson 03:42:12 INFO - building 'simplejson._speedups' extension 03:42:12 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:42:13 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:42:13 INFO - Successfully installed simplejson 03:42:13 INFO - Cleaning up... 03:42:13 INFO - Return code: 0 03:42:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, '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': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', '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:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:42:13 INFO - Using env: {'DISPLAY': ':0', 03:42:13 INFO - 'HOME': '/home/cltbld', 03:42:13 INFO - 'LANG': 'en_US.UTF-8', 03:42:13 INFO - 'LANGUAGE': 'en_US:en', 03:42:13 INFO - 'LOGNAME': 'cltbld', 03:42:13 INFO - 'MAIL': '/var/mail/cltbld', 03:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:13 INFO - 'MOZ_NO_REMOTE': '1', 03:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:13 INFO - 'NO_EM_RESTART': '1', 03:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:13 INFO - 'PWD': '/builds/slave/test', 03:42:13 INFO - 'SHELL': '/bin/bash', 03:42:13 INFO - 'SHLVL': '1', 03:42:13 INFO - 'TERM': 'linux', 03:42:13 INFO - 'TMOUT': '86400', 03:42:13 INFO - 'USER': 'cltbld', 03:42:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:13 INFO - '_': '/tools/buildbot/bin/python'} 03:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:13 INFO - Cleaning up... 03:42:13 INFO - Return code: 0 03:42:13 INFO - Running post-action listener: _resource_record_post_action 03:42:13 INFO - Running post-action listener: _start_resource_monitoring 03:42:13 INFO - Starting resource monitoring. 03:42:13 INFO - [mozharness: 2017-09-23 10:42:13.490728Z] Finished create-virtualenv step (success) 03:42:13 INFO - [mozharness: 2017-09-23 10:42:13.491252Z] Running install step. 03:42:13 INFO - Running pre-action listener: _resource_record_pre_action 03:42:13 INFO - Running main action method: install 03:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:13 INFO - Reading from file tmpfile_stdout 03:42:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:13 INFO - Reading from file tmpfile_stdout 03:42:13 INFO - Output received: 03:42:13 INFO - Usage: mozinstall [options] installer 03:42:13 INFO - Options: 03:42:13 INFO - -h, --help show this help message and exit 03:42:13 INFO - -d DEST, --destination=DEST 03:42:13 INFO - Directory to install application into. [default: 03:42:13 INFO - "/builds/slave/test"] 03:42:13 INFO - --app=APP Application being installed. [default: firefox] 03:42:13 INFO - mkdir: /builds/slave/test/build/application 03:42:13 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:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:42:31 INFO - Reading from file tmpfile_stdout 03:42:31 INFO - Output received: 03:42:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:31 INFO - Running post-action listener: _resource_record_post_action 03:42:31 INFO - [mozharness: 2017-09-23 10:42:31.834221Z] Finished install step (success) 03:42:31 INFO - [mozharness: 2017-09-23 10:42:31.834474Z] Running setup-mitmproxy step. 03:42:31 INFO - Running pre-action listener: _resource_record_pre_action 03:42:31 INFO - Running main action method: setup_mitmproxy 03:42:31 INFO - Skipping: mitmproxy is not required 03:42:31 INFO - Running post-action listener: _resource_record_post_action 03:42:31 INFO - [mozharness: 2017-09-23 10:42:31.835608Z] Finished setup-mitmproxy step (success) 03:42:31 INFO - [mozharness: 2017-09-23 10:42:31.835831Z] Running run-tests step. 03:42:31 INFO - Running pre-action listener: _resource_record_pre_action 03:42:31 INFO - Running pre-action listener: _set_gcov_prefix 03:42:31 INFO - Running main action method: run_tests 03:42:31 WARNING - Try message not found. 03:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:31 INFO - Python 2.7.3 03:42:31 INFO - Return code: 0 03:42:31 INFO - grabbing minidump binary from tooltool 03:42:31 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:42:31 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 0x14b1d60>, '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 0x14b2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b2ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:31 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:42:31 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:42:31 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:42:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:31 INFO - Return code: 0 03:42:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:31 INFO - ENV: RUST_BACKTRACE is now full 03:42:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:31 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-stylo-disabled-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-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:42:31 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-stylo-disabled-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-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:42:31 INFO - Using env: {'DISPLAY': ':0', 03:42:31 INFO - 'HOME': '/home/cltbld', 03:42:31 INFO - 'LANG': 'en_US.UTF-8', 03:42:31 INFO - 'LANGUAGE': 'en_US:en', 03:42:31 INFO - 'LOGNAME': 'cltbld', 03:42:31 INFO - 'MAIL': '/var/mail/cltbld', 03:42:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:31 INFO - 'MOZ_NO_REMOTE': '1', 03:42:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:31 INFO - 'NO_EM_RESTART': '1', 03:42:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:31 INFO - 'PWD': '/builds/slave/test', 03:42:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:31 INFO - 'RUST_BACKTRACE': 'full', 03:42:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:31 INFO - 'SHELL': '/bin/bash', 03:42:31 INFO - 'SHLVL': '1', 03:42:31 INFO - 'TERM': 'linux', 03:42:31 INFO - 'TMOUT': '86400', 03:42:31 INFO - 'USER': 'cltbld', 03:42:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:31 INFO - '_': '/tools/buildbot/bin/python'} 03:42:31 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-stylo-disabled-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-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:42:32 INFO - mozversion application_buildid: 20170923093829 03:42:32 INFO - mozversion application_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:42:32 INFO - mozversion application_display_name: Nightly 03:42:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:32 INFO - mozversion application_name: Firefox 03:42:32 INFO - mozversion application_remotingname: firefox 03:42:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:42:32 INFO - mozversion application_vendor: Mozilla 03:42:32 INFO - mozversion application_version: 58.0a1 03:42:32 INFO - mozversion platform_buildid: 20170923093829 03:42:32 INFO - mozversion platform_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:42:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:42:32 INFO - mozversion platform_version: 58.0a1 03:42:32 INFO - using testdate: 1506163352 03:42:32 INFO - actual date: 1506163352 03:42:32 INFO - starting webserver on 'localhost:57684' 03:42:32 INFO - SUITE-START | Running 2 tests 03:42:32 INFO - TEST-START | dromaeo_css 03:42:32 INFO - Initialising browser for dromaeo_css test... 03:42:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57684/getInfo.html -profile /tmp/tmpei3Adp/profile 03:42:32 INFO - TEST-INFO | started process 19973 (/builds/slave/test/build/application/firefox/firefox http://localhost:57684/getInfo.html) 03:42:38 INFO - TEST-INFO | 19973: exit 0 03:42:38 INFO - Browser initialized. 03:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:38 INFO - Using env: {'DISPLAY': ':0', 03:42:38 INFO - 'HOME': '/home/cltbld', 03:42:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:38 INFO - 'LANG': 'en_US.UTF-8', 03:42:38 INFO - 'LANGUAGE': 'en_US:en', 03:42:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:38 INFO - 'LOGNAME': 'cltbld', 03:42:38 INFO - 'MAIL': '/var/mail/cltbld', 03:42:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:38 INFO - 'MOZ_NO_REMOTE': '1', 03:42:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:38 INFO - 'NO_EM_RESTART': '1', 03:42:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:38 INFO - 'PWD': '/builds/slave/test', 03:42:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:38 INFO - 'RUST_BACKTRACE': 'full', 03:42:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:38 INFO - 'SHELL': '/bin/bash', 03:42:38 INFO - 'SHLVL': '1', 03:42:38 INFO - 'STYLO_FORCE_DISABLED': '1', 03:42:38 INFO - 'TERM': 'linux', 03:42:38 INFO - 'TMOUT': '86400', 03:42:38 INFO - 'USER': 'cltbld', 03:42:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 03:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:38 INFO - '_': '/tools/buildbot/bin/python'} 03:42:38 INFO - TEST-INFO | started process 20212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpei3Adp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:39 INFO - PID 20212 | 03:42:39 INFO - PID 20212 | (/builds/slave/test/build/application/firefox/firefox:20261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:39 INFO - PID 20212 | 03:42:49 INFO - PID 20212 | RSS: Main: 151592960 03:42:49 INFO - PID 20212 | 03:45:47 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57684/tests/dromaeo/cssquery-ext.html) 03:45:48 INFO - PID 20212 | RSS: Main: 153497600 03:45:48 INFO - PID 20212 | 03:48:49 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-ext.html (next: http://localhost:57684/tests/dromaeo/cssquery-jquery.html) 03:48:50 INFO - PID 20212 | RSS: Main: 153710592 03:48:50 INFO - PID 20212 | 03:51:52 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57684/tests/dromaeo/cssquery-mootools.html) 03:51:52 INFO - PID 20212 | RSS: Main: 154992640 03:51:52 INFO - PID 20212 | 03:54:54 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57684/tests/dromaeo/cssquery-prototype.html) 03:54:54 INFO - PID 20212 | RSS: Main: 153632768 03:54:54 INFO - PID 20212 | 03:57:58 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57684/tests/dromaeo/cssquery-yui.html) 03:57:58 INFO - PID 20212 | RSS: Main: 154423296 03:57:58 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | Cycle 1(1): loaded http://localhost:57684/tests/dromaeo/cssquery-yui.html (next: http://localhost:57684/tests/dromaeo/cssquery-dojo.html) 04:01:00 INFO - PID 20212 | RSS: Main: 156753920 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | __start_tp_report 04:01:00 INFO - PID 20212 | _x_x_mozilla_page_load 04:01:00 INFO - PID 20212 | _x_x_mozilla_page_load_details 04:01:00 INFO - PID 20212 | |i|pagename|runs| 04:01:00 INFO - PID 20212 | |0;dojo.html;3093.582366380538;3131.639861415938;3143.6227652681673;3150.9759328218333;3153.211697075731;6154.784582539612;6341.429271365576;6344.460720838734;6412.839679008021;6450.322716114805;6297.811065668026;6309.400606942333;6323.399277068683;6329.7151628176725;6385.680715964207;5895.233619629442;5938.7921422750105;5959.493443057346;5972;5990.371011043843;1378.8612858988186;5809.302883653946;5938.8218353449465;5938.851528711773;6029.5176385889245;5500.779968801243;5796.275465566804;5859.92692443075;5872.941270587282;5938.287405511344;5857.941420585782;5868.530517558628;5920.822375328704;5925.229720136398;5930.55520835939;5814.592978491507;5830.944417900943;5911.970440147815;5926.585139040269;5930.258717660293;6280.748770049193;6376.107344971708;6434.871302573969;6445.1943507061615;6448.742050318028;6652.401283884474;6748.561343512705;6828.044073829618;6908.516403851732;6923.411510021654;6819.420349270318;6825.726970921157;6829.829254268683;6832.829179270509;6834.4874134440115;6334.5249106317215;6442.291347951722;6446.097546343516;6457.80626581208;6464.353564643545;7021.648917554102;7112.35988761014;7124.180719217253;7137.072180616487;7147.64261786919;6714.664266786739;6717.1267735194115;6741.426978706865;6812.591244525245;6831.760888368884;6649.700763465656;6764.222114456802;6768.052472653832;6770.255271920085;6773.187217533928;6649.235337936103;6702.396784289437;6829.282925292872;6843.794686159423;6846.4522838172825;6837.692303846339;6873.20958089816;6907.689153988083;6911.723531058701;6920.826979325457;5339.305890234323;5348.786048558014;5418.539424148913;5419.83740487786;5426.647267927572;4562.270036794097;4650.000249946278;4670.299455081697;4693.131770622445;4730.9763451182525;5799.536037117021;5853.268341457318;5857.912131318034;5867.530597552186;5879.823605291848;6842.5552339098795;6849.691763870638;6858.691358888862;6928.272531384233;6936.7572134975035;5832.50423713989;5898.997170481029;5909.704514774244;5912.556558258148;5922.230110085661;5747.3677895431465;5845.912311315334;5848.093545500455;5861.677607731531;5918.704064796743;6538.117354157223;6568.704408301543;6591.505637077238;6660.600363978177;6669.4330981866115;6821.522493425413;6903.930960690429;6934.514583979073;6934.583924964519;6952.5480843745;6576.408123268738;6583.63789991555;6610.272869984394;6701.832454188684;6703.899441508283;6514.967425162844;6662.966685166543;6682.799516014527;6728.764493242713;6823.454123670193;6884.070650462124;6891.724331026703;6936.861262774615;6941.2364639888565;6942.6181560012665;6633.402993730588;6642.236142843635;6741.52809303344;6742;6745.561538500178;6640.634765087966;6645.435138013129;6672.199336079701;6744.460443164437;6755.392014718699;6390.041493775785;6512.08830763684;6521.250056243593;6567.376099270562;6659.001149827371;6706.195256569243;6728.293529179561;6731.764388246388;6760.459163267025;6801.1158549388265;6257.155284036597;6389.073584330339;6423.100765892686;6493.740250389931;6499.5775274607 04:01:00 INFO - PID 20212 | |1;ext.html;881.3257857738829;897.7620930453435;900.8468560344741;907.9364444488887;917.9449233046014;40911;41946.7902660487;42086;42121.78939105308;42272;38708.225835483274;38849.223015539676;39263.21473570527;39371.21257574847;39376.803115984454;7133.108361454818;7241.71033158673;7273.599952002638;7281.34467897889;7301.379382752472;7210.062691850052;7280.4903656744045;7287.453440991921;7295.124585049802;7297.817554561126;7836.686532538692;8050;8052.235037671441;8052.677892884278;8073.273405393514;7946.602669866484;7951.324137448324;8012.799680007988;8031.9598402007905;8035.397345199104;7794.727184548514;7824.804379890491;7853.371730261565;8006.1993800619475;8055.194480551956;37700.43449348262;37858.62141378606;38080.80959595212;38178.236435271414;38222.61777382218;3515.771474854126;3523.295340931824;3540.5574303212097;3545.4150065239205;3545.840437180333;31354;31597.21006974821;31600.683993160004;31625.84187079073;31706.524402133986;5189.455107213726;5192.247124167013;5214.739263036833;5218.973905130488;5221.660592061542;169748.30251697448;179456.10271948556;179684;180374;180495;42265.57734422678;47685.76157119192;48180;48241.517584823705;48247;49018.754906225244;49297.26054109191;49572.75213623981;49624.50375496199;49643.75178124086;15799.526014219591;15836.92081539585;15894.682106357808;15917.124558149413;15940.840591593935;13159.934200328937;13225.27261000635;13256.734865302833;13261.933690331487;13268.13757105785;13519.729605407836;13637.727245455035;13651.317434128254;13661.795073073912;13802.723945521033;5276.630635855453;5374.220737992969;5439.673619582838;5515.200295957064;5557.749901254453;1001.47923079998;1021.4177918586334;1024.90263424976;1040.3705758016442;1042.8435734639866;23096.884515577316;23205.651915221286;23218.65172022421;23456.64815027776;23475.29574112745;1120.38938778366;1126.4987080749152;1131.5530365505579;1139.943002849854;1147.776183644198;12224.877751222373;12237.69405764863;12421.254724716546;12445.315507646985;12483.438245278985;203300;204621;204674;204709;204908;50059.24911126336;50219.24671129936;50525.49474505281;50541.49458505442;50631.74684126629;1425.4369524037947;1470.213435811857;1482.3774014913763;1482.85171482853;1483.4659522571865;22281.220157294418;22288.331350059525;22338.66492002654;22621;23047.88476057609;36771.81614092019;36879;36899;36908.077298067765;37026.25947481089;174202;174278;174491;175307;175574;31466.21334466565;32767.672323276463;32882.67117328796;32916.341673166884;33027.66972330246;42099.57900420957;42239;42272;42437.78781106075;42721.57278427176;31779.523307150874;31781.841090794398;31945.361092777548;32032;32425.35149297048;31561.8421907889;31567.36865262636;31705.68294317027;31995.680043200202;32212.516812248305;35578.46632300569;35654.108647284025;35772.4634130483;36016.09959751027;36062.278754425286;30596.84701576478;30942;31398.686013139577;31553.21116972094;31660;22654;23036.654450182927;23394.76605233994;23415.88292058529;23714.88142559276 04:01:00 INFO - PID 20212 | |2;jquery.html;593.448093273256;602.1118849696697;603.7403916315984;606.4360145065087;622.200472392975;21789.67315490267;22536.09855605774;22544.774552254472;22572.322830315075;22649.660255096147;24355;26528.33679158022;26764.59853102205;26765.197044088658;26779.33051673704;6627.734890604382;6793.728250869959;6796.0485532025305;6796.592204467723;6803.965980170092;6653.733850645968;6700;6919.550229235108;7226.963865180666;7263.418926485869;7240.493165478419;7246.5289756165685;7250.891236631454;7251.347378735913;7253.637318134099;7166.283371662844;7170.60561669108;7193.604351760651;7228.746993855242;7244.782656520313;7024.086868707086;7024.964875175642;7048.083749112634;7048.259932707095;7051.330123638298;30010;31120.37759244825;31259.218519536968;31334.843325783226;31528.842355788074;2046.7953204679561;2065.1120018392085;2076.2317942361424;2078.4803799050237;2080.895955202234;20866.895665521577;21381.572368552697;21437.571248575096;21478.248261310935;21539.67690484644;2428.2836563213896;2448.3389484838995;2548.350170706458;2613.033177724235;2618.1621880998086;142846;145585;145669;146075.26962365228;146102.26948865294;18952.267291185137;21119.472013199487;21555.67666485004;22257.777422225896;22428.66357004646;23429.531409371717;24399.146029889223;42644.57355426468;42951.570484295386;42984.57015429805;10441.321314114559;10472.319299245524;10495.737606559896;10550.683479495627;10771.78456430867;9635.662751803653;9662.323637345458;9694.660686875926;9839;9842.50787460624;9187.402818816756;9388.718338449857;9469.431834089977;9728.513574321256;9889.950550247202;2732;2739.657617706395;2810.7329803668617;2866.5556838690036;2890.36411989362;973.8928717841031;987.2792861211356;1001.2790790630734;1001.6293971230691;1005.2711783956719;19604.70592941107;19954.90022549878;20237.595248094956;20398.082086305854;20637.89681051615;1055.403696911258;1062.6865074802952;1067.4769363012067;1069.502681253221;1072.3780207479642;10911.727206819734;11141.888581114246;11363.488643010918;11431.685356184145;11450.370229637283;492086;495844;499020;502072;504065;106438.46780766202;108484.45757771161;109098;109765;111688.4415577917;1159.5941420502757;1192.451472322724;1207.535098986879;1212.3392750950752;1219.036960800975;18075.819241807414;18330.633387331913;18334.908325458287;18350.265989360276;18503.722444163617;54609;57068.429315706315;57211.427885722274;57367;58756.41243587509;66767.33232667611;67434;67765.3223467759;68303.31696683168;70239.64880175567;14862.777058343918;15111.773323399937;15313.46402875894;15333.693326133192;15371.692566148839;23189;23208.18771342995;23216.76783232146;23474.882625586764;23559.175428859908;18508.537286567942;18591.44225673232;18761;18816.15327310247;18912.52718682044;15723.921380393025;15799;17062.829371706124;17289.65420691554;17314.826851731323;18247.726284105484;18454.538636534195;18520;18583;18806.811931881053;14757.114573125647;14812.851871481578;14930.10419374841;14940.103593784408;14975.550733478012;18271.54321141982;18459.169337379582;18475.353362632242;18619.534511637317;18661.346852860086 04:01:00 INFO - PID 20212 | |3;mootools.html;1276.2406368210916;1365.133140455811;1379.4068550523275;1391.9930400347996;1395.5743498233041;14884;15411.46059887904;15471.845281547181;15482.84517154828;15502;15285.388584456608;15390.30743616537;15415.3833846646;15428.3828646854;15429.845701542981;2742.5749008903654;2763.1296141715397;2840.6875243723175;2842.943141137176;2847.017778866298;2773.362126710858;2823.3365159187574;2845.260232339586;2853.158318296097;2853.3865218977917;2755.2973991632107;2794.706555811641;2878.165332053702;2880.29432788967;2880.7983441159126;2824.138637715496;2838.1769286906774;2862.2415060009116;2880.2079428157217;2882.942341153165;2665.267051560817;2674.1977406777887;2679.4507126039116;2718.2932437566374;2825.590289408045;14618.926905365404;14835;14847.25763711821;14855.92572037133;14873.553793386216;8071;8438.873416898752;8455.704050358208;8461.280791132762;8472.152784721478;5360.410354860962;5478.369987451414;5559.777608895639;5597.188407680864;5606.607537472379;1918.4340619517277;1929.5947850951318;1961.990190049055;1990.1143990924045;1991.1836147179588;27083.864580677167;27549.586756198674;27659.308517287027;27743.30641733973;27768.444631107468;7298.452616053817;7393.852122957511;7503.324700776956;7565.130010048805;7641.541507509567;20160.59678806416;20194.293199738233;20196;20228.089735961916;20242.089105990264;8384.077751447336;8519.275861551838;8522.829543409222;8544.40189186751;8546.700865469678;7447.404207663374;7576.545407275581;7641.579713115721;7694.038245219348;7700.268474494914;5809.390014048464;5896.616719913192;5918.970405147947;5962.552808539377;6025.969870150709;1793.3185389551886;1804.9187786549373;1867.264457569667;1878.915448804807;1884.387574038443;895.9372843900994;899.0559912092408;910.1035480052143;920.2729843423754;920.9355345125776;7617.27635874591;7630.16068232505;7639.847203056019;7651.3496352809525;7693.846123077619;712.4976891291627;724.3625609463638;726.3825748114166;726.7274771960515;735;4892.902141957212;5377.112776391929;5391;5418.187271909166;5488.286522752017;21237.78762212389;21807.23674671379;22181;22259.44351391196;22269.443263918532;20278.69581956272;21219.46951326198;21368.145274188857;21429.78570214309;21577.352679419644;11126.609173853269;11161.553537858557;11235.438228088562;11277;11351.318920864775;8129.105798362294;8299.08710041907;8366.16338366183;8426.368022398223;8455.365847561334;18391.63216735631;18629.627407451502;18830.152643131365;18897.90551047236;18939.14773835153;19364.70952935735;19425.320113795948;19485.123169457125;19549.51126221856;19916.302929397403;12190.939045304716;12264;12274.81587776202;12357.25856448616;12371.381430928597;13625.795613065613;13795.931020344835;13796.793048104488;13797.10318829273;13802.102863313852;10936.398498082683;10953.452327383759;10985.231033827555;11077.556897724;11140.944295278472;10601.840972385575;10794.838077428687;10919.672409827717;11076.944615276872;11294.774104518028;9416.435013899189;9676.467794271382;9677.419354838732;9693.757656058655;9707.320487565803;6644.368784965421;6648.335166483506;6826.351496607815;6866.176058872968;6896.172459304916;6950.51346405767;7002.2297547268745;7008.264132266243;7019.543729657556;7041.964790176016 04:01:00 INFO - PID 20212 | |4;prototype.html;509.49190396426576;534.9648430287394;546.2516352596942;547.4580165636022;548.8326060551533;6334.714937827797;6394.392532709397;6425.261094974079;6439.066335381367;6475.70859311331;6245.656488893109;6317.010141805328;6331.620102793836;6361.300256971729;6428.132202152708;5279.973600131994;5332.440093790135;5336.226247194155;5364.946350536484;5369.073854749171;4934.703917764928;5138.3577052868395;5197.350331208599;5338.172583249583;5354.625176237665;5090.567301779334;5123.4108077571;5130.974345128269;5137.126688462951;5143.614228932826;5009.89980200394;5038.773255203525;5074.3657042869645;5109.9744501277255;5151.948480515184;4576.679632425698;4580.908381832378;4606.60843828275;4636.675432719711;4639.744814035227;6309.211348581427;6320.4198950262435;6321.747130114836;6325.5255855811;6328.873422531569;5781.768729250825;5785.681787501686;5887.35239123696;5926.496247818941;5945.583809133363;6616.239132499728;6685.966570167118;6700.162479690039;6702.128723265993;6708.182563323416;4975.7263350515705;5016.097102521545;5041.445441001487;5064.341635587387;5069.543741063322;6676.365745254193;6713;6847.589144651287;6854.560542286126;6961.164660240804;5139.12634852076;5146.974265128651;5160.535551800356;5194;5206.76569554371;5212.478752124757;5234.869128271747;5235.869103272448;5256.737163141827;5279.155335146435;5866.941330586725;5892.263467066617;5894.263217097863;5894.410558944071;5902.173695682608;6607.76872809459;6659.367360100783;6703.262641109474;6773.1872175338285;6782.796516104525;1776.5736223306571;1780.4391616640717;1782.1267578886511;1785.9910700446414;1813.8186181381757;1192.701824543864;1231.8337024501757;1251.3492983648634;1253.2605762599928;1255.919908878364;5759.827205183768;5765.1928729977835;5783.652980821164;5801.158831969426;5813.215215945793;6707.6981535831;6755.864882702318;6777.542828291941;6851.965740171367;6934;5768.183022347947;5785.595008349375;5804.2744656917885;5880.500157486576;5945.394743419339;3612.385894397906;3639.872604458831;3641.7450778445786;3644.799536025491;3660.652238037382;6630.933690663128;6648.268690444047;6677.53257271996;6693.431058360094;6706.698198581075;7111.661886249383;7114.608696521741;7132.821679458055;7167.462440316997;7183.281671832775;6528;6648.501362397743;6652;6714.29499902513;6722.764703235461;6711.530192886451;6770.187577490733;6789.490788190807;6813.420859226823;6824.335801285021;6689.01668257132;6690.264070952094;6726.932730672826;6727.730890764315;6827.180738311435;6608.4052435281055;6634.966825165843;6642.3025582315095;6696.19645642526;6776.966115169393;5130.58955283569;5136.970896495788;5160.509751573594;5175.635836706171;5184.7926082956255;6602.60384376939;6617.338266173344;6739.93260067393;6759.262498688039;6791.422729068085;6444.258910225384;6527.2167339919515;6621.867562648817;6675.766348177791;6712.83217919556;6585.967070164618;6638.269790322964;6650.268470468148;6682.933170668425;6695.832604184934;6472.902906456313;6479.708413121515;6545.770898018737;6597.80206593803;6638;6701.463882889455;6702.664866756741;6709.678709039057;6711.516738806673;6715.7985260442265;6498.772542960974;6526.379993900572;6578.703958321791;6580.5722628029025;6582.76960306387 04:01:00 INFO - PID 20212 | |5;yui.html;877.9341549383798;921.2307723051252;936.7096200177946;937.2221056523082;953.2564599612302;19530.414087577377;20455.488612784688;20482.385528434133;20493.590128197447;20503.38489845307;18774.06129693513;18781.34265300715;18962.525936851587;19474.123664435097;19706.11322490488;961.6393852305386;964.3587014635277;964.6575465709677;966.8163049020663;966.9991558736709;981.6711401680445;986.6250824686609;986.6497393425338;987.0524296675164;987.2940847294183;1000.7348052766023;1030.4847576211894;1030.7680771826354;1032.076291718911;1037.6886933919793;993.9304248702593;1010.3028910052077;1010.9646162384281;1011.6560369474378;1027.0499787696351;719.7301012120455;738.3428748413916;740.5963749756396;746.171749358212;749.8200431896361;20636.174553018012;20885.791142088536;20898.059587318607;20900.477488062766;20922.895385523127;21400.35798926035;21541.24605638795;22141.778582214134;22331.99506022233;22429.66355504669;15897.52307430779;16276.348946042144;16351.672966540602;16393.34426622934;16442;3695.57500887396;3722.4788529605876;3724.478572999782;3724.8696295629793;3725.3666876631037;142211.99999999895;142422;143305.283473583;143379;146542.26728866287;16702.83297167037;17064.402745903833;17192.742108868377;17195.914020429816;17220.827791721924;30594;31327.37345253082;32130.678693213235;32139.35721285561;32351.029469115965;8460.323174146053;8570.700025499078;8572.485650860968;8577.142285771373;8579.356548258906;4326.069894972596;4355.564443555682;4450.1767173073085;4484.753338566345;4496.910061798746;5436.972815135899;5545.833624991256;5549.139883318092;5550.333959924835;5562.360328562268;1016.5730393234859;1031.169908223872;1044.1542350695809;1053.4206186597341;1055.778286559831;657.6481582353418;661.6658587413325;681.1621705302506;685.807973767346;696.2932623387265;11252.831207531894;11261.493232804543;11527.654170374903;12432.067594930235;12840.743185136245;644.8162273752052;662.4270006444488;670.3129292475252;675.5237557521936;682.8258794007496;5455.318085239345;5547.362053363915;5624.0439125348785;5638.97180514103;5639.802606908738;121560.39219803845;122128;123190.38404807918;123887.38056309841;126312;86605;98630;105012;107129;108437;91653.99999999866;92249;92830;93738.24455320642;93902.53048734849;12911.741765164832;13186.274754888573;13250.668733281746;13269.867301326864;13377.264250466318;43819.56180438282;44297.77851110724;44321.556784433036;45133.09733805371;45518;57571.42428575828;58041.709791450776;58595.70702146462;58757.70621146867;59853.40146598478;16282.348706051625;16322;16375.263113160174;16382.672346553241;16599.087050212354;20545.58908821845;20879.791202087785;20894.164233430492;21201.15195392167;21241.36275911725;18635.81364186341;19107.426777196706;19131;19277.325293614656;19335.323263685703;18346.174422151304;18543.16555755021;18587.535311617317;18592.070396479852;18717.344892928682;15259.542213733606;15351.539453816404;15475.458358957383;15558.144302063496;15654.686906262039;13324.666883327995;13481.123726958109;13696.52062177819;13796.793048104086;13851.515196968461;13767.793483097561;13855.584332470042;13918.37367318453;14116.164898563122;14126 04:01:00 INFO - PID 20212 | __end_tp_report 04:01:00 INFO - PID 20212 | __start_cc_report 04:01:00 INFO - PID 20212 | _x_x_mozilla_cycle_collect,283 04:01:00 INFO - PID 20212 | __end_cc_report 04:01:00 INFO - PID 20212 | __startTimestamp1506164460758__endTimestamp 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | ------- Summary: start ------- 04:01:00 INFO - PID 20212 | Number of tests: 6 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#0] dojo.html Cycles:165 Average:6256.35 Median:6514.97 stddev:856.64 (13.1%) stddev-sans-first:822.55 04:01:00 INFO - PID 20212 | Values: 3093.6 3131.6 3143.6 3151.0 3153.2 6154.8 6341.4 6344.5 6412.8 6450.3 6297.8 6309.4 6323.4 6329.7 6385.7 5895.2 5938.8 5959.5 5972.0 5990.4 1378.9 5809.3 5938.8 5938.9 6029.5 5500.8 5796.3 5859.9 5872.9 5938.3 5857.9 5868.5 5920.8 5925.2 5930.6 5814.6 5830.9 5912.0 5926.6 5930.3 6280.7 6376.1 6434.9 6445.2 6448.7 6652.4 6748.6 6828.0 6908.5 6923.4 6819.4 6825.7 6829.8 6832.8 6834.5 6334.5 6442.3 6446.1 6457.8 6464.4 7021.6 7112.4 7124.2 7137.1 7147.6 6714.7 6717.1 6741.4 6812.6 6831.8 6649.7 6764.2 6768.1 6770.3 6773.2 6649.2 6702.4 6829.3 6843.8 6846.5 6837.7 6873.2 6907.7 6911.7 6920.8 5339.3 5348.8 5418.5 5419.8 5426.6 4562.3 4650.0 4670.3 4693.1 4731.0 5799.5 5853.3 5857.9 5867.5 5879.8 6842.6 6849.7 6858.7 6928.3 6936.8 5832.5 5899.0 5909.7 5912.6 5922.2 5747.4 5845.9 5848.1 5861.7 5918.7 6538.1 6568.7 6591.5 6660.6 6669.4 6821.5 6903.9 6934.5 6934.6 6952.5 6576.4 6583.6 6610.3 6701.8 6703.9 6515.0 6663.0 6682.8 6728.8 6823.5 6884.1 6891.7 6936.9 6941.2 6942.6 6633.4 6642.2 6741.5 6742.0 6745.6 6640.6 6645.4 6672.2 6744.5 6755.4 6390.0 6512.1 6521.3 6567.4 6659.0 6706.2 6728.3 6731.8 6760.5 6801.1 6257.2 6389.1 6423.1 6493.7 6499.6 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#1] ext.html Cycles:180 Average:35514.19 Median:3519.53 stddev:48085.09 (1366.2%) stddev-sans-first:48149.66 04:01:00 INFO - PID 20212 | Values: 881.3 897.8 900.8 907.9 917.9 40911.0 41946.8 42086.0 42121.8 42272.0 38708.2 38849.2 39263.2 39371.2 39376.8 7133.1 7241.7 7273.6 7281.3 7301.4 7210.1 7280.5 7287.5 7295.1 7297.8 7836.7 8050.0 8052.2 8052.7 8073.3 7946.6 7951.3 8012.8 8032.0 8035.4 7794.7 7824.8 7853.4 8006.2 8055.2 37700.4 37858.6 38080.8 38178.2 38222.6 3515.8 3523.3 3540.6 3545.4 3545.8 31354.0 31597.2 31600.7 31625.8 31706.5 5189.5 5192.2 5214.7 5219.0 5221.7 169748.3 179456.1 179684.0 180374.0 180495.0 42265.6 47685.8 48180.0 48241.5 48247.0 49018.8 49297.3 49572.8 49624.5 49643.8 15799.5 15836.9 15894.7 15917.1 15940.8 13159.9 13225.3 13256.7 13261.9 13268.1 13519.7 13637.7 13651.3 13661.8 13802.7 5276.6 5374.2 5439.7 5515.2 5557.7 1001.5 1021.4 1024.9 1040.4 1042.8 23096.9 23205.7 23218.7 23456.6 23475.3 1120.4 1126.5 1131.6 1139.9 1147.8 12224.9 12237.7 12421.3 12445.3 12483.4 203300.0 204621.0 204674.0 204709.0 204908.0 50059.2 50219.2 50525.5 50541.5 50631.7 1425.4 1470.2 1482.4 1482.9 1483.5 22281.2 22288.3 22338.7 22621.0 23047.9 36771.8 36879.0 36899.0 36908.1 37026.3 174202.0 174278.0 174491.0 175307.0 175574.0 31466.2 32767.7 32882.7 32916.3 33027.7 42099.6 42239.0 42272.0 42437.8 42721.6 31779.5 31781.8 31945.4 32032.0 32425.4 31561.8 31567.4 31705.7 31995.7 32212.5 35578.5 35654.1 35772.5 36016.1 36062.3 30596.8 30942.0 31398.7 31553.2 31660.0 22654.0 23036.7 23394.8 23415.9 23714.9 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#2] jquery.html Cycles:180 Average:35763.58 Median:22558.55 stddev:83838.02 (371.6%) stddev-sans-first:84031.62 04:01:00 INFO - PID 20212 | Values: 593.4 602.1 603.7 606.4 622.2 21789.7 22536.1 22544.8 22572.3 22649.7 24355.0 26528.3 26764.6 26765.2 26779.3 6627.7 6793.7 6796.0 6796.6 6804.0 6653.7 6700.0 6919.6 7227.0 7263.4 7240.5 7246.5 7250.9 7251.3 7253.6 7166.3 7170.6 7193.6 7228.7 7244.8 7024.1 7025.0 7048.1 7048.3 7051.3 30010.0 31120.4 31259.2 31334.8 31528.8 2046.8 2065.1 2076.2 2078.5 2080.9 20866.9 21381.6 21437.6 21478.2 21539.7 2428.3 2448.3 2548.4 2613.0 2618.2 142846.0 145585.0 145669.0 146075.3 146102.3 18952.3 21119.5 21555.7 22257.8 22428.7 23429.5 24399.1 42644.6 42951.6 42984.6 10441.3 10472.3 10495.7 10550.7 10771.8 9635.7 9662.3 9694.7 9839.0 9842.5 9187.4 9388.7 9469.4 9728.5 9890.0 2732.0 2739.7 2810.7 2866.6 2890.4 973.9 987.3 1001.3 1001.6 1005.3 19604.7 19954.9 20237.6 20398.1 20637.9 1055.4 1062.7 1067.5 1069.5 1072.4 10911.7 11141.9 11363.5 11431.7 11450.4 492086.0 495844.0 499020.0 502072.0 504065.0 106438.5 108484.5 109098.0 109765.0 111688.4 1159.6 1192.5 1207.5 1212.3 1219.0 18075.8 18330.6 18334.9 18350.3 18503.7 54609.0 57068.4 57211.4 57367.0 58756.4 66767.3 67434.0 67765.3 68303.3 70239.6 14862.8 15111.8 15313.5 15333.7 15371.7 23189.0 23208.2 23216.8 23474.9 23559.2 18508.5 18591.4 18761.0 18816.2 18912.5 15723.9 15799.0 17062.8 17289.7 17314.8 18247.7 18454.5 18520.0 18583.0 18806.8 14757.1 14812.9 14930.1 14940.1 14975.6 18271.5 18459.2 18475.4 18619.5 18661.3 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#3] mootools.html Cycles:180 Average:9526.08 Median:15258.33 stddev:6851.33 (44.9%) stddev-sans-first:6842.51 04:01:00 INFO - PID 20212 | Values: 1276.2 1365.1 1379.4 1392.0 1395.6 14884.0 15411.5 15471.8 15482.8 15502.0 15285.4 15390.3 15415.4 15428.4 15429.8 2742.6 2763.1 2840.7 2842.9 2847.0 2773.4 2823.3 2845.3 2853.2 2853.4 2755.3 2794.7 2878.2 2880.3 2880.8 2824.1 2838.2 2862.2 2880.2 2882.9 2665.3 2674.2 2679.5 2718.3 2825.6 14618.9 14835.0 14847.3 14855.9 14873.6 8071.0 8438.9 8455.7 8461.3 8472.2 5360.4 5478.4 5559.8 5597.2 5606.6 1918.4 1929.6 1962.0 1990.1 1991.2 27083.9 27549.6 27659.3 27743.3 27768.4 7298.5 7393.9 7503.3 7565.1 7641.5 20160.6 20194.3 20196.0 20228.1 20242.1 8384.1 8519.3 8522.8 8544.4 8546.7 7447.4 7576.5 7641.6 7694.0 7700.3 5809.4 5896.6 5919.0 5962.6 6026.0 1793.3 1804.9 1867.3 1878.9 1884.4 895.9 899.1 910.1 920.3 920.9 7617.3 7630.2 7639.8 7651.3 7693.8 712.5 724.4 726.4 726.7 735.0 4892.9 5377.1 5391.0 5418.2 5488.3 21237.8 21807.2 22181.0 22259.4 22269.4 20278.7 21219.5 21368.1 21429.8 21577.4 11126.6 11161.6 11235.4 11277.0 11351.3 8129.1 8299.1 8366.2 8426.4 8455.4 18391.6 18629.6 18830.2 18897.9 18939.1 19364.7 19425.3 19485.1 19549.5 19916.3 12190.9 12264.0 12274.8 12357.3 12371.4 13625.8 13795.9 13796.8 13797.1 13802.1 10936.4 10953.5 10985.2 11077.6 11140.9 10601.8 10794.8 10919.7 11076.9 11294.8 9416.4 9676.5 9677.4 9693.8 9707.3 6644.4 6648.3 6826.4 6866.2 6896.2 6950.5 7002.2 7008.3 7019.5 7042.0 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#4] prototype.html Cycles:180 Average:5639.11 Median:6327.20 stddev:1565.41 (24.7%) stddev-sans-first:1521.72 04:01:00 INFO - PID 20212 | Values: 509.5 535.0 546.3 547.5 548.8 6334.7 6394.4 6425.3 6439.1 6475.7 6245.7 6317.0 6331.6 6361.3 6428.1 5280.0 5332.4 5336.2 5364.9 5369.1 4934.7 5138.4 5197.4 5338.2 5354.6 5090.6 5123.4 5131.0 5137.1 5143.6 5009.9 5038.8 5074.4 5110.0 5151.9 4576.7 4580.9 4606.6 4636.7 4639.7 6309.2 6320.4 6321.7 6325.5 6328.9 5781.8 5785.7 5887.4 5926.5 5945.6 6616.2 6686.0 6700.2 6702.1 6708.2 4975.7 5016.1 5041.4 5064.3 5069.5 6676.4 6713.0 6847.6 6854.6 6961.2 5139.1 5147.0 5160.5 5194.0 5206.8 5212.5 5234.9 5235.9 5256.7 5279.2 5866.9 5892.3 5894.3 5894.4 5902.2 6607.8 6659.4 6703.3 6773.2 6782.8 1776.6 1780.4 1782.1 1786.0 1813.8 1192.7 1231.8 1251.3 1253.3 1255.9 5759.8 5765.2 5783.7 5801.2 5813.2 6707.7 6755.9 6777.5 6852.0 6934.0 5768.2 5785.6 5804.3 5880.5 5945.4 3612.4 3639.9 3641.7 3644.8 3660.7 6630.9 6648.3 6677.5 6693.4 6706.7 7111.7 7114.6 7132.8 7167.5 7183.3 6528.0 6648.5 6652.0 6714.3 6722.8 6711.5 6770.2 6789.5 6813.4 6824.3 6689.0 6690.3 6726.9 6727.7 6827.2 6608.4 6635.0 6642.3 6696.2 6777.0 5130.6 5137.0 5160.5 5175.6 5184.8 6602.6 6617.3 6739.9 6759.3 6791.4 6444.3 6527.2 6621.9 6675.8 6712.8 6586.0 6638.3 6650.3 6682.9 6695.8 6472.9 6479.7 6545.8 6597.8 6638.0 6701.5 6702.7 6709.7 6711.5 6715.8 6498.8 6526.4 6578.7 6580.6 6582.8 04:01:00 INFO - PID 20212 | 04:01:00 INFO - PID 20212 | [#5] yui.html Cycles:180 Average:24735.03 Median:20889.98 stddev:35040.25 (167.7%) stddev-sans-first:35092.76 04:01:00 INFO - PID 20212 | Values: 877.9 921.2 936.7 937.2 953.3 19530.4 20455.5 20482.4 20493.6 20503.4 18774.1 18781.3 18962.5 19474.1 19706.1 961.6 964.4 964.7 966.8 967.0 981.7 986.6 986.6 987.1 987.3 1000.7 1030.5 1030.8 1032.1 1037.7 993.9 1010.3 1011.0 1011.7 1027.0 719.7 738.3 740.6 746.2 749.8 20636.2 20885.8 20898.1 20900.5 20922.9 21400.4 21541.2 22141.8 22332.0 22429.7 15897.5 16276.3 16351.7 16393.3 16442.0 3695.6 3722.5 3724.5 3724.9 3725.4 142212.0 142422.0 143305.3 143379.0 146542.3 16702.8 17064.4 17192.7 17195.9 17220.8 30594.0 31327.4 32130.7 32139.4 32351.0 8460.3 8570.7 8572.5 8577.1 8579.4 4326.1 4355.6 4450.2 4484.8 4496.9 5437.0 5545.8 5549.1 5550.3 5562.4 1016.6 1031.2 1044.2 1053.4 1055.8 657.6 661.7 681.2 685.8 696.3 11252.8 11261.5 11527.7 12432.1 12840.7 644.8 662.4 670.3 675.5 682.8 5455.3 5547.4 5624.0 5639.0 5639.8 121560.4 122128.0 123190.4 123887.4 126312.0 86605.0 98630.0 105012.0 107129.0 108437.0 91654.0 92249.0 92830.0 93738.2 93902.5 12911.7 13186.3 13250.7 13269.9 13377.3 43819.6 44297.8 44321.6 45133.1 45518.0 57571.4 58041.7 58595.7 58757.7 59853.4 16282.3 16322.0 16375.3 16382.7 16599.1 20545.6 20879.8 20894.2 21201.2 21241.4 18635.8 19107.4 19131.0 19277.3 19335.3 18346.2 18543.2 18587.5 18592.1 18717.3 15259.5 15351.5 15475.5 15558.1 15654.7 13324.7 13481.1 13696.5 13796.8 13851.5 13767.8 13855.6 13918.4 14116.2 14126.0 04:01:00 INFO - PID 20212 | -------- Summary: end -------- 04:01:00 INFO - PID 20212 | 04:01:01 INFO - TEST-INFO | 20212: exit 0 04:01:01 INFO - TEST-OK | dromaeo_css | took 1109195ms 04:01:01 INFO - TEST-START | kraken 04:01:01 INFO - Initialising browser for kraken test... 04:01:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57684/getInfo.html -profile /tmp/tmpszddfe/profile 04:01:01 INFO - TEST-INFO | started process 20568 (/builds/slave/test/build/application/firefox/firefox http://localhost:57684/getInfo.html) 04:01:07 INFO - TEST-INFO | 20568: exit 0 04:01:07 INFO - Browser initialized. 04:01:07 INFO - Running cycle 1/1 for kraken test... 04:01:07 INFO - Using env: {'DISPLAY': ':0', 04:01:07 INFO - 'HOME': '/home/cltbld', 04:01:07 INFO - 'JSGC_DISABLE_POISONING': '1', 04:01:07 INFO - 'LANG': 'en_US.UTF-8', 04:01:07 INFO - 'LANGUAGE': 'en_US:en', 04:01:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:01:07 INFO - 'LOGNAME': 'cltbld', 04:01:07 INFO - 'MAIL': '/var/mail/cltbld', 04:01:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:07 INFO - 'MOZ_CRASHREPORTER': '1', 04:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:01:07 INFO - 'MOZ_NO_REMOTE': '1', 04:01:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:07 INFO - 'NO_EM_RESTART': '1', 04:01:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:07 INFO - 'PWD': '/builds/slave/test', 04:01:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:07 INFO - 'RUST_BACKTRACE': 'full', 04:01:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:07 INFO - 'SHELL': '/bin/bash', 04:01:07 INFO - 'SHLVL': '1', 04:01:07 INFO - 'STYLO_FORCE_DISABLED': '1', 04:01:07 INFO - 'TERM': 'linux', 04:01:07 INFO - 'TMOUT': '86400', 04:01:07 INFO - 'USER': 'cltbld', 04:01:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050', 04:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:07 INFO - '_': '/tools/buildbot/bin/python'} 04:01:07 INFO - TEST-INFO | started process 20802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpszddfe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:07 INFO - PID 20802 | 04:01:07 INFO - PID 20802 | (/builds/slave/test/build/application/firefox/firefox:20851): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:01:07 INFO - PID 20802 | 04:01:18 INFO - PID 20802 | RSS: Main: 151789568 04:01:18 INFO - PID 20802 | 04:01:20 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57684/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:21 INFO - PID 20802 | RSS: Main: 157716480 04:01:21 INFO - PID 20802 | 04:01:24 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57684/tests/kraken/driver.html?testName=audio-dft) 04:01:25 INFO - PID 20802 | RSS: Main: 157356032 04:01:25 INFO - PID 20802 | 04:01:28 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57684/tests/kraken/driver.html?testName=audio-fft) 04:01:28 INFO - PID 20802 | RSS: Main: 154636288 04:01:28 INFO - PID 20802 | 04:01:30 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57684/tests/kraken/driver.html?testName=audio-oscillator) 04:01:31 INFO - PID 20802 | RSS: Main: 155549696 04:01:31 INFO - PID 20802 | 04:01:33 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:34 INFO - PID 20802 | RSS: Main: 155844608 04:01:34 INFO - PID 20802 | 04:01:37 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57684/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:37 INFO - PID 20802 | RSS: Main: 157851648 04:01:37 INFO - PID 20802 | 04:01:41 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57684/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:42 INFO - PID 20802 | RSS: Main: 158044160 04:01:42 INFO - PID 20802 | 04:01:45 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57684/tests/kraken/driver.html?testName=json-parse-financial) 04:01:45 INFO - PID 20802 | RSS: Main: 157626368 04:01:45 INFO - PID 20802 | 04:01:47 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:48 INFO - PID 20802 | RSS: Main: 158208000 04:01:48 INFO - PID 20802 | 04:01:49 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:50 INFO - PID 20802 | RSS: Main: 158109696 04:01:50 INFO - PID 20802 | 04:01:52 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:53 INFO - PID 20802 | RSS: Main: 154963968 04:01:53 INFO - PID 20802 | 04:01:55 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:56 INFO - PID 20802 | RSS: Main: 155254784 04:01:56 INFO - PID 20802 | 04:01:59 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:59 INFO - PID 20802 | RSS: Main: 155258880 04:01:59 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | Cycle 1(1): loaded http://localhost:57684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57684/tests/kraken/driver.html?testName=ai-astar) 04:02:01 INFO - PID 20802 | RSS: Main: 156422144 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | __start_tp_report 04:02:01 INFO - PID 20802 | _x_x_mozilla_page_load 04:02:01 INFO - PID 20802 | _x_x_mozilla_page_load_details 04:02:01 INFO - PID 20802 | |i|pagename|runs| 04:02:01 INFO - PID 20802 | |0;ai-astar;108;108;107;108;106;108;122;107;107;111 04:02:01 INFO - PID 20802 | |1;audio-beat-detection;116;122;117;117;121;116;141;117;117;117 04:02:01 INFO - PID 20802 | |2;audio-dft;164;161;164;165;163;161;163;163;167;166 04:02:01 INFO - PID 20802 | |3;audio-fft;74;74;79;76;74;74;74;76;74;75 04:02:01 INFO - PID 20802 | |4;audio-oscillator;82;79;81;80;80;81;80;81;85;80 04:02:01 INFO - PID 20802 | |5;imaging-gaussian-blur;114;113;114;114;114;113;115;114;114;114 04:02:01 INFO - PID 20802 | |6;imaging-darkroom;152;148;148;148;148;149;148;148;147;148 04:02:01 INFO - PID 20802 | |7;imaging-desaturate;98;95;94;94;95;107;94;95;95;94 04:02:01 INFO - PID 20802 | |8;json-parse-financial;54;52;55;53;53;56;55;55;55;55 04:02:01 INFO - PID 20802 | |9;json-stringify-tinderbox;39;39;38;38;38;37;38;38;38;38 04:02:01 INFO - PID 20802 | |10;stanford-crypto-aes;77;78;78;77;74;75;79;77;76;78 04:02:01 INFO - PID 20802 | |11;stanford-crypto-ccm;121;112;116;117;114;108;117;112;114;111 04:02:01 INFO - PID 20802 | |12;stanford-crypto-pbkdf2;168;169;175;175;170;169;169;168;176;178 04:02:01 INFO - PID 20802 | |13;stanford-crypto-sha256-iterative;68;71;65;64;65;65;67;67;66;65 04:02:01 INFO - PID 20802 | __end_tp_report 04:02:01 INFO - PID 20802 | __start_cc_report 04:02:01 INFO - PID 20802 | _x_x_mozilla_cycle_collect,738 04:02:01 INFO - PID 20802 | __end_cc_report 04:02:01 INFO - PID 20802 | __startTimestamp1506164521799__endTimestamp 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | ------- Summary: start ------- 04:02:01 INFO - PID 20802 | Number of tests: 14 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#0] ai-astar Cycles:10 Average:109.20 Median:108.00 stddev:4.69 (4.3%) stddev-sans-first:4.95 04:02:01 INFO - PID 20802 | Values: 108.0 108.0 107.0 108.0 106.0 108.0 122.0 107.0 107.0 111.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:117.00 stddev:7.62 (6.5%) stddev-sans-first:7.94 04:02:01 INFO - PID 20802 | Values: 116.0 122.0 117.0 117.0 121.0 116.0 141.0 117.0 117.0 117.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.95 (1.2%) stddev-sans-first:2.06 04:02:01 INFO - PID 20802 | Values: 164.0 161.0 164.0 165.0 163.0 161.0 163.0 163.0 167.0 166.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#3] audio-fft Cycles:10 Average:75.00 Median:74.50 stddev:1.63 (2.2%) stddev-sans-first:1.69 04:02:01 INFO - PID 20802 | Values: 74.0 74.0 79.0 76.0 74.0 74.0 74.0 76.0 74.0 75.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:81.00 stddev:1.66 (2.1%) stddev-sans-first:1.72 04:02:01 INFO - PID 20802 | Values: 82.0 79.0 81.0 80.0 80.0 81.0 80.0 81.0 85.0 80.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:02:01 INFO - PID 20802 | Values: 114.0 113.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 114.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.35 (0.9%) stddev-sans-first:0.50 04:02:01 INFO - PID 20802 | Values: 152.0 148.0 148.0 148.0 148.0 149.0 148.0 148.0 147.0 148.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:4.01 (4.2%) stddev-sans-first:4.20 04:02:01 INFO - PID 20802 | Values: 98.0 95.0 94.0 94.0 95.0 107.0 94.0 95.0 95.0 94.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.32 04:02:01 INFO - PID 20802 | Values: 54.0 52.0 55.0 53.0 53.0 56.0 55.0 55.0 55.0 55.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.50 04:02:01 INFO - PID 20802 | Values: 39.0 39.0 38.0 38.0 38.0 37.0 38.0 38.0 38.0 38.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.50 stddev:1.52 (2.0%) stddev-sans-first:1.62 04:02:01 INFO - PID 20802 | Values: 77.0 78.0 78.0 77.0 74.0 75.0 79.0 77.0 76.0 78.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.00 stddev:3.71 (3.2%) stddev-sans-first:3.00 04:02:01 INFO - PID 20802 | Values: 121.0 112.0 116.0 117.0 114.0 108.0 117.0 112.0 114.0 111.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:3.83 (2.2%) stddev-sans-first:3.82 04:02:01 INFO - PID 20802 | Values: 168.0 169.0 175.0 175.0 170.0 169.0 169.0 168.0 176.0 178.0 04:02:01 INFO - PID 20802 | 04:02:01 INFO - PID 20802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:2.06 (3.1%) stddev-sans-first:2.09 04:02:01 INFO - PID 20802 | Values: 68.0 71.0 65.0 64.0 65.0 65.0 67.0 67.0 66.0 65.0 04:02:01 INFO - PID 20802 | -------- Summary: end -------- 04:02:01 INFO - PID 20802 | 04:02:02 INFO - PID 20802 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:02:02 INFO - TEST-INFO | 20802: exit 0 04:02:02 INFO - TEST-OK | kraken | took 61081ms 04:02:02 INFO - SUITE-END | took 1170s 04:02:02 INFO - Completed test suite (00:19:30) 04:02:02 INFO - javascript benchmark 04:02:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8676.033112271629, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.582366380538, 3131.639861415938, 3143.6227652681673, 3150.9759328218333, 3153.211697075731, 6154.784582539612, 6341.429271365576, 6344.460720838734, 6412.839679008021, 6450.322716114805, 6297.811065668026, 6309.400606942333, 6323.399277068683, 6329.7151628176725, 6385.680715964207, 5895.233619629442, 5938.7921422750105, 5959.493443057346, 5972.0, 5990.371011043843, 1378.8612858988186, 5809.302883653946, 5938.8218353449465, 5938.851528711773, 6029.5176385889245, 5500.779968801243, 5796.275465566804, 5859.92692443075, 5872.941270587282, 5938.287405511344, 5857.941420585782, 5868.530517558628, 5920.822375328704, 5925.229720136398, 5930.55520835939, 5814.592978491507, 5830.944417900943, 5911.970440147815, 5926.585139040269, 5930.258717660293, 6280.748770049193, 6376.107344971708, 6434.871302573969, 6445.1943507061615, 6448.742050318028, 6652.401283884474, 6748.561343512705, 6828.044073829618, 6908.516403851732, 6923.411510021654, 6819.420349270318, 6825.726970921157, 6829.829254268683, 6832.829179270509, 6834.4874134440115, 6334.5249106317215, 6442.291347951722, 6446.097546343516, 6457.80626581208, 6464.353564643545, 7021.648917554102, 7112.35988761014, 7124.180719217253, 7137.072180616487, 7147.64261786919, 6714.664266786739, 6717.1267735194115, 6741.426978706865, 6812.591244525245, 6831.760888368884, 6649.700763465656, 6764.222114456802, 6768.052472653832, 6770.255271920085, 6773.187217533928, 6649.235337936103, 6702.396784289437, 6829.282925292872, 6843.794686159423, 6846.4522838172825, 6837.692303846339, 6873.20958089816, 6907.689153988083, 6911.723531058701, 6920.826979325457, 5339.305890234323, 5348.786048558014, 5418.539424148913, 5419.83740487786, 5426.647267927572, 4562.270036794097, 4650.000249946278, 4670.299455081697, 4693.131770622445, 4730.9763451182525, 5799.536037117021, 5853.268341457318, 5857.912131318034, 5867.530597552186, 5879.823605291848, 6842.5552339098795, 6849.691763870638, 6858.691358888862, 6928.272531384233, 6936.7572134975035, 5832.50423713989, 5898.997170481029, 5909.704514774244, 5912.556558258148, 5922.230110085661, 5747.3677895431465, 5845.912311315334, 5848.093545500455, 5861.677607731531, 5918.704064796743, 6538.117354157223, 6568.704408301543, 6591.505637077238, 6660.600363978177, 6669.4330981866115, 6821.522493425413, 6903.930960690429, 6934.514583979073, 6934.583924964519, 6952.5480843745, 6576.408123268738, 6583.63789991555, 6610.272869984394, 6701.832454188684, 6703.899441508283, 6514.967425162844, 6662.966685166543, 6682.799516014527, 6728.764493242713, 6823.454123670193, 6884.070650462124, 6891.724331026703, 6936.861262774615, 6941.2364639888565, 6942.6181560012665, 6633.402993730588, 6642.236142843635, 6741.52809303344, 6742.0, 6745.561538500178, 6640.634765087966, 6645.435138013129, 6672.199336079701, 6744.460443164437, 6755.392014718699, 6390.041493775785, 6512.08830763684, 6521.250056243593, 6567.376099270562, 6659.001149827371, 6706.195256569243, 6728.293529179561, 6731.764388246388, 6760.459163267025, 6801.1158549388265, 6257.155284036597, 6389.073584330339, 6423.100765892686, 6493.740250389931, 6499.5775274607], "value": 6192.440664178379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.3257857738829, 897.7620930453435, 900.8468560344741, 907.9364444488887, 917.9449233046014, 40911.0, 41946.7902660487, 42086.0, 42121.78939105308, 42272.0, 38708.225835483274, 38849.223015539676, 39263.21473570527, 39371.21257574847, 39376.803115984454, 7133.108361454818, 7241.71033158673, 7273.599952002638, 7281.34467897889, 7301.379382752472, 7210.062691850052, 7280.4903656744045, 7287.453440991921, 7295.124585049802, 7297.817554561126, 7836.686532538692, 8050.0, 8052.235037671441, 8052.677892884278, 8073.273405393514, 7946.602669866484, 7951.324137448324, 8012.799680007988, 8031.9598402007905, 8035.397345199104, 7794.727184548514, 7824.804379890491, 7853.371730261565, 8006.1993800619475, 8055.194480551956, 37700.43449348262, 37858.62141378606, 38080.80959595212, 38178.236435271414, 38222.61777382218, 3515.771474854126, 3523.295340931824, 3540.5574303212097, 3545.4150065239205, 3545.840437180333, 31354.0, 31597.21006974821, 31600.683993160004, 31625.84187079073, 31706.524402133986, 5189.455107213726, 5192.247124167013, 5214.739263036833, 5218.973905130488, 5221.660592061542, 169748.30251697448, 179456.10271948556, 179684.0, 180374.0, 180495.0, 42265.57734422678, 47685.76157119192, 48180.0, 48241.517584823705, 48247.0, 49018.754906225244, 49297.26054109191, 49572.75213623981, 49624.50375496199, 49643.75178124086, 15799.526014219591, 15836.92081539585, 15894.682106357808, 15917.124558149413, 15940.840591593935, 13159.934200328937, 13225.27261000635, 13256.734865302833, 13261.933690331487, 13268.13757105785, 13519.729605407836, 13637.727245455035, 13651.317434128254, 13661.795073073912, 13802.723945521033, 5276.630635855453, 5374.220737992969, 5439.673619582838, 5515.200295957064, 5557.749901254453, 1001.47923079998, 1021.4177918586334, 1024.90263424976, 1040.3705758016442, 1042.8435734639866, 23096.884515577316, 23205.651915221286, 23218.65172022421, 23456.64815027776, 23475.29574112745, 1120.38938778366, 1126.4987080749152, 1131.5530365505579, 1139.943002849854, 1147.776183644198, 12224.877751222373, 12237.69405764863, 12421.254724716546, 12445.315507646985, 12483.438245278985, 203300.0, 204621.0, 204674.0, 204709.0, 204908.0, 50059.24911126336, 50219.24671129936, 50525.49474505281, 50541.49458505442, 50631.74684126629, 1425.4369524037947, 1470.213435811857, 1482.3774014913763, 1482.85171482853, 1483.4659522571865, 22281.220157294418, 22288.331350059525, 22338.66492002654, 22621.0, 23047.88476057609, 36771.81614092019, 36879.0, 36899.0, 36908.077298067765, 37026.25947481089, 174202.0, 174278.0, 174491.0, 175307.0, 175574.0, 31466.21334466565, 32767.672323276463, 32882.67117328796, 32916.341673166884, 33027.66972330246, 42099.57900420957, 42239.0, 42272.0, 42437.78781106075, 42721.57278427176, 31779.523307150874, 31781.841090794398, 31945.361092777548, 32032.0, 32425.35149297048, 31561.8421907889, 31567.36865262636, 31705.68294317027, 31995.680043200202, 32212.516812248305, 35578.46632300569, 35654.108647284025, 35772.4634130483, 36016.09959751027, 36062.278754425286, 30596.84701576478, 30942.0, 31398.686013139577, 31553.21116972094, 31660.0, 22654.0, 23036.654450182927, 23394.76605233994, 23415.88292058529, 23714.88142559276], "value": 16873.43979730802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.448093273256, 602.1118849696697, 603.7403916315984, 606.4360145065087, 622.200472392975, 21789.67315490267, 22536.09855605774, 22544.774552254472, 22572.322830315075, 22649.660255096147, 24355.0, 26528.33679158022, 26764.59853102205, 26765.197044088658, 26779.33051673704, 6627.734890604382, 6793.728250869959, 6796.0485532025305, 6796.592204467723, 6803.965980170092, 6653.733850645968, 6700.0, 6919.550229235108, 7226.963865180666, 7263.418926485869, 7240.493165478419, 7246.5289756165685, 7250.891236631454, 7251.347378735913, 7253.637318134099, 7166.283371662844, 7170.60561669108, 7193.604351760651, 7228.746993855242, 7244.782656520313, 7024.086868707086, 7024.964875175642, 7048.083749112634, 7048.259932707095, 7051.330123638298, 30010.0, 31120.37759244825, 31259.218519536968, 31334.843325783226, 31528.842355788074, 2046.7953204679561, 2065.1120018392085, 2076.2317942361424, 2078.4803799050237, 2080.895955202234, 20866.895665521577, 21381.572368552697, 21437.571248575096, 21478.248261310935, 21539.67690484644, 2428.2836563213896, 2448.3389484838995, 2548.350170706458, 2613.033177724235, 2618.1621880998086, 142846.0, 145585.0, 145669.0, 146075.26962365228, 146102.26948865294, 18952.267291185137, 21119.472013199487, 21555.67666485004, 22257.777422225896, 22428.66357004646, 23429.531409371717, 24399.146029889223, 42644.57355426468, 42951.570484295386, 42984.57015429805, 10441.321314114559, 10472.319299245524, 10495.737606559896, 10550.683479495627, 10771.78456430867, 9635.662751803653, 9662.323637345458, 9694.660686875926, 9839.0, 9842.50787460624, 9187.402818816756, 9388.718338449857, 9469.431834089977, 9728.513574321256, 9889.950550247202, 2732.0, 2739.657617706395, 2810.7329803668617, 2866.5556838690036, 2890.36411989362, 973.8928717841031, 987.2792861211356, 1001.2790790630734, 1001.6293971230691, 1005.2711783956719, 19604.70592941107, 19954.90022549878, 20237.595248094956, 20398.082086305854, 20637.89681051615, 1055.403696911258, 1062.6865074802952, 1067.4769363012067, 1069.502681253221, 1072.3780207479642, 10911.727206819734, 11141.888581114246, 11363.488643010918, 11431.685356184145, 11450.370229637283, 492086.0, 495844.0, 499020.0, 502072.0, 504065.0, 106438.46780766202, 108484.45757771161, 109098.0, 109765.0, 111688.4415577917, 1159.5941420502757, 1192.451472322724, 1207.535098986879, 1212.3392750950752, 1219.036960800975, 18075.819241807414, 18330.633387331913, 18334.908325458287, 18350.265989360276, 18503.722444163617, 54609.0, 57068.429315706315, 57211.427885722274, 57367.0, 58756.41243587509, 66767.33232667611, 67434.0, 67765.3223467759, 68303.31696683168, 70239.64880175567, 14862.777058343918, 15111.773323399937, 15313.46402875894, 15333.693326133192, 15371.692566148839, 23189.0, 23208.18771342995, 23216.76783232146, 23474.882625586764, 23559.175428859908, 18508.537286567942, 18591.44225673232, 18761.0, 18816.15327310247, 18912.52718682044, 15723.921380393025, 15799.0, 17062.829371706124, 17289.65420691554, 17314.826851731323, 18247.726284105484, 18454.538636534195, 18520.0, 18583.0, 18806.811931881053, 14757.114573125647, 14812.851871481578, 14930.10419374841, 14940.103593784408, 14975.550733478012, 18271.54321141982, 18459.169337379582, 18475.353362632242, 18619.534511637317, 18661.346852860086], "value": 12593.883481023564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.2406368210916, 1365.133140455811, 1379.4068550523275, 1391.9930400347996, 1395.5743498233041, 14884.0, 15411.46059887904, 15471.845281547181, 15482.84517154828, 15502.0, 15285.388584456608, 15390.30743616537, 15415.3833846646, 15428.3828646854, 15429.845701542981, 2742.5749008903654, 2763.1296141715397, 2840.6875243723175, 2842.943141137176, 2847.017778866298, 2773.362126710858, 2823.3365159187574, 2845.260232339586, 2853.158318296097, 2853.3865218977917, 2755.2973991632107, 2794.706555811641, 2878.165332053702, 2880.29432788967, 2880.7983441159126, 2824.138637715496, 2838.1769286906774, 2862.2415060009116, 2880.2079428157217, 2882.942341153165, 2665.267051560817, 2674.1977406777887, 2679.4507126039116, 2718.2932437566374, 2825.590289408045, 14618.926905365404, 14835.0, 14847.25763711821, 14855.92572037133, 14873.553793386216, 8071.0, 8438.873416898752, 8455.704050358208, 8461.280791132762, 8472.152784721478, 5360.410354860962, 5478.369987451414, 5559.777608895639, 5597.188407680864, 5606.607537472379, 1918.4340619517277, 1929.5947850951318, 1961.990190049055, 1990.1143990924045, 1991.1836147179588, 27083.864580677167, 27549.586756198674, 27659.308517287027, 27743.30641733973, 27768.444631107468, 7298.452616053817, 7393.852122957511, 7503.324700776956, 7565.130010048805, 7641.541507509567, 20160.59678806416, 20194.293199738233, 20196.0, 20228.089735961916, 20242.089105990264, 8384.077751447336, 8519.275861551838, 8522.829543409222, 8544.40189186751, 8546.700865469678, 7447.404207663374, 7576.545407275581, 7641.579713115721, 7694.038245219348, 7700.268474494914, 5809.390014048464, 5896.616719913192, 5918.970405147947, 5962.552808539377, 6025.969870150709, 1793.3185389551886, 1804.9187786549373, 1867.264457569667, 1878.915448804807, 1884.387574038443, 895.9372843900994, 899.0559912092408, 910.1035480052143, 920.2729843423754, 920.9355345125776, 7617.27635874591, 7630.16068232505, 7639.847203056019, 7651.3496352809525, 7693.846123077619, 712.4976891291627, 724.3625609463638, 726.3825748114166, 726.7274771960515, 735.0, 4892.902141957212, 5377.112776391929, 5391.0, 5418.187271909166, 5488.286522752017, 21237.78762212389, 21807.23674671379, 22181.0, 22259.44351391196, 22269.443263918532, 20278.69581956272, 21219.46951326198, 21368.145274188857, 21429.78570214309, 21577.352679419644, 11126.609173853269, 11161.553537858557, 11235.438228088562, 11277.0, 11351.318920864775, 8129.105798362294, 8299.08710041907, 8366.16338366183, 8426.368022398223, 8455.365847561334, 18391.63216735631, 18629.627407451502, 18830.152643131365, 18897.90551047236, 18939.14773835153, 19364.70952935735, 19425.320113795948, 19485.123169457125, 19549.51126221856, 19916.302929397403, 12190.939045304716, 12264.0, 12274.81587776202, 12357.25856448616, 12371.381430928597, 13625.795613065613, 13795.931020344835, 13796.793048104488, 13797.10318829273, 13802.102863313852, 10936.398498082683, 10953.452327383759, 10985.231033827555, 11077.556897724, 11140.944295278472, 10601.840972385575, 10794.838077428687, 10919.672409827717, 11076.944615276872, 11294.774104518028, 9416.435013899189, 9676.467794271382, 9677.419354838732, 9693.757656058655, 9707.320487565803, 6644.368784965421, 6648.335166483506, 6826.351496607815, 6866.176058872968, 6896.172459304916, 6950.51346405767, 7002.2297547268745, 7008.264132266243, 7019.543729657556, 7041.964790176016], "value": 6790.337822789037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.49190396426576, 534.9648430287394, 546.2516352596942, 547.4580165636022, 548.8326060551533, 6334.714937827797, 6394.392532709397, 6425.261094974079, 6439.066335381367, 6475.70859311331, 6245.656488893109, 6317.010141805328, 6331.620102793836, 6361.300256971729, 6428.132202152708, 5279.973600131994, 5332.440093790135, 5336.226247194155, 5364.946350536484, 5369.073854749171, 4934.703917764928, 5138.3577052868395, 5197.350331208599, 5338.172583249583, 5354.625176237665, 5090.567301779334, 5123.4108077571, 5130.974345128269, 5137.126688462951, 5143.614228932826, 5009.89980200394, 5038.773255203525, 5074.3657042869645, 5109.9744501277255, 5151.948480515184, 4576.679632425698, 4580.908381832378, 4606.60843828275, 4636.675432719711, 4639.744814035227, 6309.211348581427, 6320.4198950262435, 6321.747130114836, 6325.5255855811, 6328.873422531569, 5781.768729250825, 5785.681787501686, 5887.35239123696, 5926.496247818941, 5945.583809133363, 6616.239132499728, 6685.966570167118, 6700.162479690039, 6702.128723265993, 6708.182563323416, 4975.7263350515705, 5016.097102521545, 5041.445441001487, 5064.341635587387, 5069.543741063322, 6676.365745254193, 6713.0, 6847.589144651287, 6854.560542286126, 6961.164660240804, 5139.12634852076, 5146.974265128651, 5160.535551800356, 5194.0, 5206.76569554371, 5212.478752124757, 5234.869128271747, 5235.869103272448, 5256.737163141827, 5279.155335146435, 5866.941330586725, 5892.263467066617, 5894.263217097863, 5894.410558944071, 5902.173695682608, 6607.76872809459, 6659.367360100783, 6703.262641109474, 6773.1872175338285, 6782.796516104525, 1776.5736223306571, 1780.4391616640717, 1782.1267578886511, 1785.9910700446414, 1813.8186181381757, 1192.701824543864, 1231.8337024501757, 1251.3492983648634, 1253.2605762599928, 1255.919908878364, 5759.827205183768, 5765.1928729977835, 5783.652980821164, 5801.158831969426, 5813.215215945793, 6707.6981535831, 6755.864882702318, 6777.542828291941, 6851.965740171367, 6934.0, 5768.183022347947, 5785.595008349375, 5804.2744656917885, 5880.500157486576, 5945.394743419339, 3612.385894397906, 3639.872604458831, 3641.7450778445786, 3644.799536025491, 3660.652238037382, 6630.933690663128, 6648.268690444047, 6677.53257271996, 6693.431058360094, 6706.698198581075, 7111.661886249383, 7114.608696521741, 7132.821679458055, 7167.462440316997, 7183.281671832775, 6528.0, 6648.501362397743, 6652.0, 6714.29499902513, 6722.764703235461, 6711.530192886451, 6770.187577490733, 6789.490788190807, 6813.420859226823, 6824.335801285021, 6689.01668257132, 6690.264070952094, 6726.932730672826, 6727.730890764315, 6827.180738311435, 6608.4052435281055, 6634.966825165843, 6642.3025582315095, 6696.19645642526, 6776.966115169393, 5130.58955283569, 5136.970896495788, 5160.509751573594, 5175.635836706171, 5184.7926082956255, 6602.60384376939, 6617.338266173344, 6739.93260067393, 6759.262498688039, 6791.422729068085, 6444.258910225384, 6527.2167339919515, 6621.867562648817, 6675.766348177791, 6712.83217919556, 6585.967070164618, 6638.269790322964, 6650.268470468148, 6682.933170668425, 6695.832604184934, 6472.902906456313, 6479.708413121515, 6545.770898018737, 6597.80206593803, 6638.0, 6701.463882889455, 6702.664866756741, 6709.678709039057, 6711.516738806673, 6715.7985260442265, 6498.772542960974, 6526.379993900572, 6578.703958321791, 6580.5722628029025, 6582.76960306387], "value": 5178.753288207038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.9341549383798, 921.2307723051252, 936.7096200177946, 937.2221056523082, 953.2564599612302, 19530.414087577377, 20455.488612784688, 20482.385528434133, 20493.590128197447, 20503.38489845307, 18774.06129693513, 18781.34265300715, 18962.525936851587, 19474.123664435097, 19706.11322490488, 961.6393852305386, 964.3587014635277, 964.6575465709677, 966.8163049020663, 966.9991558736709, 981.6711401680445, 986.6250824686609, 986.6497393425338, 987.0524296675164, 987.2940847294183, 1000.7348052766023, 1030.4847576211894, 1030.7680771826354, 1032.076291718911, 1037.6886933919793, 993.9304248702593, 1010.3028910052077, 1010.9646162384281, 1011.6560369474378, 1027.0499787696351, 719.7301012120455, 738.3428748413916, 740.5963749756396, 746.171749358212, 749.8200431896361, 20636.174553018012, 20885.791142088536, 20898.059587318607, 20900.477488062766, 20922.895385523127, 21400.35798926035, 21541.24605638795, 22141.778582214134, 22331.99506022233, 22429.66355504669, 15897.52307430779, 16276.348946042144, 16351.672966540602, 16393.34426622934, 16442.0, 3695.57500887396, 3722.4788529605876, 3724.478572999782, 3724.8696295629793, 3725.3666876631037, 142211.99999999895, 142422.0, 143305.283473583, 143379.0, 146542.26728866287, 16702.83297167037, 17064.402745903833, 17192.742108868377, 17195.914020429816, 17220.827791721924, 30594.0, 31327.37345253082, 32130.678693213235, 32139.35721285561, 32351.029469115965, 8460.323174146053, 8570.700025499078, 8572.485650860968, 8577.142285771373, 8579.356548258906, 4326.069894972596, 4355.564443555682, 4450.1767173073085, 4484.753338566345, 4496.910061798746, 5436.972815135899, 5545.833624991256, 5549.139883318092, 5550.333959924835, 5562.360328562268, 1016.5730393234859, 1031.169908223872, 1044.1542350695809, 1053.4206186597341, 1055.778286559831, 657.6481582353418, 661.6658587413325, 681.1621705302506, 685.807973767346, 696.2932623387265, 11252.831207531894, 11261.493232804543, 11527.654170374903, 12432.067594930235, 12840.743185136245, 644.8162273752052, 662.4270006444488, 670.3129292475252, 675.5237557521936, 682.8258794007496, 5455.318085239345, 5547.362053363915, 5624.0439125348785, 5638.97180514103, 5639.802606908738, 121560.39219803845, 122128.0, 123190.38404807918, 123887.38056309841, 126312.0, 86605.0, 98630.0, 105012.0, 107129.0, 108437.0, 91653.99999999866, 92249.0, 92830.0, 93738.24455320642, 93902.53048734849, 12911.741765164832, 13186.274754888573, 13250.668733281746, 13269.867301326864, 13377.264250466318, 43819.56180438282, 44297.77851110724, 44321.556784433036, 45133.09733805371, 45518.0, 57571.42428575828, 58041.709791450776, 58595.70702146462, 58757.70621146867, 59853.40146598478, 16282.348706051625, 16322.0, 16375.263113160174, 16382.672346553241, 16599.087050212354, 20545.58908821845, 20879.791202087785, 20894.164233430492, 21201.15195392167, 21241.36275911725, 18635.81364186341, 19107.426777196706, 19131.0, 19277.325293614656, 19335.323263685703, 18346.174422151304, 18543.16555755021, 18587.535311617317, 18592.070396479852, 18717.344892928682, 15259.542213733606, 15351.539453816404, 15475.458358957383, 15558.144302063496, 15654.686906262039, 13324.666883327995, 13481.123726958109, 13696.52062177819, 13796.793048104086, 13851.515196968461, 13767.793483097561, 13855.584332470042, 13918.37367318453, 14116.164898563122, 14126.0], "value": 9216.382718681387, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 108.0, 106.0, 108.0, 122.0, 107.0, 107.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 117.0, 117.0, 121.0, 116.0, 141.0, 117.0, 117.0, 117.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 165.0, 163.0, 161.0, 163.0, 163.0, 167.0, 166.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 79.0, 76.0, 74.0, 74.0, 74.0, 76.0, 74.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 80.0, 80.0, 81.0, 80.0, 81.0, 85.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 94.0, 95.0, 107.0, 94.0, 95.0, 95.0, 94.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 55.0, 53.0, 53.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 77.0, 74.0, 75.0, 79.0, 77.0, 76.0, 78.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 112.0, 116.0, 117.0, 114.0, 108.0, 117.0, 112.0, 114.0, 111.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 175.0, 175.0, 170.0, 169.0, 169.0, 168.0, 176.0, 178.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 65.0, 64.0, 65.0, 65.0, 67.0, 67.0, 66.0, 65.0], "value": 66.3, "unit": "score"}]}]} 04:02:03 INFO - Return code: 0 04:02:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:03 INFO - # TBPL SUCCESS # 04:02:03 INFO - Running post-action listener: _package_coverage_data 04:02:03 INFO - Running post-action listener: _resource_record_post_action 04:02:03 INFO - [mozharness: 2017-09-23 11:02:03.112405Z] Finished run-tests step (success) 04:02:03 INFO - Running post-run listener: _resource_record_post_run 04:02:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 344977408; Read time: 20; Write time: 200708 04:02:03 INFO - TinderboxPrint: CPU usage
13.1% 04:02:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 04:02:03 INFO - TinderboxPrint: I/O write bytes / time
344,977,408 / 200,708 04:02:03 INFO - TinderboxPrint: CPU idle
8,235.8 (86.9%) 04:02:03 INFO - TinderboxPrint: CPU user
1,194.8 (12.6%) 04:02:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:02:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10145792; Read time: 0; Write time: 844 04:02:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:02:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 334831616; Read time: 8; Write time: 199864 04:02:03 INFO - Running post-run listener: _upload_blobber_files 04:02:03 INFO - Blob upload gear active. 04:02:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:02:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:05 INFO - (blobuploader) - INFO - Done attempting. 04:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:06 INFO - (blobuploader) - INFO - Done attempting. 04:02:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:13 INFO - (blobuploader) - INFO - Done attempting. 04:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:14 INFO - (blobuploader) - INFO - Done attempting. 04:02:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:14 INFO - Return code: 0 04:02:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef60c2782373c90fbbcfc0cb93782092c305ae7a4698a9ecbdcc66e42ca3f5bce202a7737b51f4a65c1a559088a7fd7824fdd6bfe93ee355211097e891245873", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c083bb1fac5d68e4e4c3e787c2aec9a9f7b587d4cca428272fa17a8d328fcef3612d8e3dd6344c11045e6e2f53c5c9bc0a4c86adcab7c0223aa4520a77c31e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdf2ee541015edb38b324c32f6dd27bb4d5bba57e5cb100265a5a7531a28008ef95e28a8a9df23e0b5f83072c909c2d853405fed1e5dc53f6b5e8bdb7040cb84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28b9ce3fd84d8cfbad71caf827439a53f99b2fe91affab1cc174f832aa11fa5703ddffd5e040cfe554447987113f5f90dcab98f37e4d9f679eb52ab031eb46e2"} 04:02:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:14 INFO - Contents: 04:02:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef60c2782373c90fbbcfc0cb93782092c305ae7a4698a9ecbdcc66e42ca3f5bce202a7737b51f4a65c1a559088a7fd7824fdd6bfe93ee355211097e891245873", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c083bb1fac5d68e4e4c3e787c2aec9a9f7b587d4cca428272fa17a8d328fcef3612d8e3dd6344c11045e6e2f53c5c9bc0a4c86adcab7c0223aa4520a77c31e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdf2ee541015edb38b324c32f6dd27bb4d5bba57e5cb100265a5a7531a28008ef95e28a8a9df23e0b5f83072c909c2d853405fed1e5dc53f6b5e8bdb7040cb84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28b9ce3fd84d8cfbad71caf827439a53f99b2fe91affab1cc174f832aa11fa5703ddffd5e040cfe554447987113f5f90dcab98f37e4d9f679eb52ab031eb46e2"} 04:02:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:14 INFO - Copying logs to upload dir... 04:02:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.274565 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 04:02:14.626889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:02:14.631936) ========= 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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 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/ef60c2782373c90fbbcfc0cb93782092c305ae7a4698a9ecbdcc66e42ca3f5bce202a7737b51f4a65c1a559088a7fd7824fdd6bfe93ee355211097e891245873", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c083bb1fac5d68e4e4c3e787c2aec9a9f7b587d4cca428272fa17a8d328fcef3612d8e3dd6344c11045e6e2f53c5c9bc0a4c86adcab7c0223aa4520a77c31e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdf2ee541015edb38b324c32f6dd27bb4d5bba57e5cb100265a5a7531a28008ef95e28a8a9df23e0b5f83072c909c2d853405fed1e5dc53f6b5e8bdb7040cb84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28b9ce3fd84d8cfbad71caf827439a53f99b2fe91affab1cc174f832aa11fa5703ddffd5e040cfe554447987113f5f90dcab98f37e4d9f679eb52ab031eb46e2"} build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 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/ef60c2782373c90fbbcfc0cb93782092c305ae7a4698a9ecbdcc66e42ca3f5bce202a7737b51f4a65c1a559088a7fd7824fdd6bfe93ee355211097e891245873", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c083bb1fac5d68e4e4c3e787c2aec9a9f7b587d4cca428272fa17a8d328fcef3612d8e3dd6344c11045e6e2f53c5c9bc0a4c86adcab7c0223aa4520a77c31e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdf2ee541015edb38b324c32f6dd27bb4d5bba57e5cb100265a5a7531a28008ef95e28a8a9df23e0b5f83072c909c2d853405fed1e5dc53f6b5e8bdb7040cb84", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28b9ce3fd84d8cfbad71caf827439a53f99b2fe91affab1cc174f832aa11fa5703ddffd5e040cfe554447987113f5f90dcab98f37e4d9f679eb52ab031eb46e2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:02:14.668859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:02:14.669329) ========= 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=920470bf432669ad7e3a5387000001ca-1506163293.47100-1459840050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:02:14.748672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:02:14.752233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:02:14.752789) ========= ========= Total master_lag: 0.23 =========