builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-083 starttime: 1506853585.42 results: success (0) revision: f90790f7a34616b1e878f3a6f536546e048e21e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.423334) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.423939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.424210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.442224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.442600) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-01 03:26:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-10-01 03:26:25 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.585333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.585654) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019642 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.639716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:25.640026) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f90790f7a34616b1e878f3a6f536546e048e21e6 --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 f90790f7a34616b1e878f3a6f536546e048e21e6 --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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-01 03:26:25,671 truncating revision to first 12 chars 2017-10-01 03:26:25,671 Setting DEBUG logging. 2017-10-01 03:26:25,671 attempt 1/10 2017-10-01 03:26:25,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f90790f7a346?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-01 03:26:26,050 unpacking tar archive at: mozilla-central-f90790f7a346/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:26.366983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:26.367284) ========= script_repo_revision: f90790f7a34616b1e878f3a6f536546e048e21e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:26.367644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:26.367919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 03:26:26.390742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-10-01 03:26:26.391089) ========= /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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:26 INFO - MultiFileLogger online at 20171001 03:26:26 in /builds/slave/test 03:26:26 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:26:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:26 INFO - {'append_to_log': False, 03:26:26 INFO - 'base_work_dir': '/builds/slave/test', 03:26:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:26:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:26 INFO - 'branch': 'Firefox-Non-PGO', 03:26:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:26 INFO - 'code_coverage': False, 03:26:26 INFO - 'config_files': ('talos/linux_config.py',), 03:26:26 INFO - 'default_actions': ('clobber', 03:26:26 INFO - 'read-buildbot-config', 03:26:26 INFO - 'download-and-extract', 03:26:26 INFO - 'populate-webroot', 03:26:26 INFO - 'create-virtualenv', 03:26:26 INFO - 'install', 03:26:26 INFO - 'setup-mitmproxy', 03:26:26 INFO - 'run-tests'), 03:26:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:26 INFO - 'disable_ccov_upload': False, 03:26:26 INFO - 'disable_stylo': False, 03:26:26 INFO - 'download_minidump_stackwalk': True, 03:26:26 INFO - 'download_symbols': 'ondemand', 03:26:26 INFO - 'enable_stylo': False, 03:26:26 INFO - 'enable_webrender': False, 03:26:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:26:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:26 INFO - 'gecko_profile': False, 03:26:26 INFO - 'gecko_profile_interval': 0, 03:26:26 INFO - 'installer_path': 'installer.exe', 03:26:26 INFO - 'log_level': 'info', 03:26:26 INFO - 'log_name': 'talos', 03:26:26 INFO - 'log_to_console': True, 03:26:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:26 INFO - 'opt_config_files': (), 03:26:26 INFO - 'pip_index': False, 03:26:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:26:26 INFO - 'system_bits': '32', 03:26:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:26 INFO - 'title': 'talos-linux64-ix-083', 03:26:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:26 INFO - 'use_talos_json': True, 03:26:26 INFO - 'verify': 'False', 03:26:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:26 INFO - 'work_dir': 'build'} 03:26:26 INFO - [mozharness: 2017-10-01 10:26:26.563695Z] Running clobber step. 03:26:26 INFO - Running pre-action listener: _resource_record_pre_action 03:26:26 INFO - Running main action method: clobber 03:26:26 INFO - rmtree: /builds/slave/test/build 03:26:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:28 INFO - Running post-action listener: _resource_record_post_action 03:26:28 INFO - [mozharness: 2017-10-01 10:26:28.080952Z] Finished clobber step (success) 03:26:28 INFO - [mozharness: 2017-10-01 10:26:28.081050Z] Running read-buildbot-config step. 03:26:28 INFO - Running pre-action listener: _resource_record_pre_action 03:26:28 INFO - Running main action method: read_buildbot_config 03:26:28 INFO - Using buildbot properties: 03:26:28 INFO - { 03:26:28 INFO - "project": "", 03:26:28 INFO - "product": "firefox", 03:26:28 INFO - "who": "archaeopteryx@coole-files.de", 03:26:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:26:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:26:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:26:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:26:28 INFO - "stage_platform": "linux64", 03:26:28 INFO - "basedir": "/builds/slave/test", 03:26:28 INFO - "buildnumber": 86, 03:26:28 INFO - "platform": "ubuntu64_hw", 03:26:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:26:28 INFO - "slavebuilddir": "test", 03:26:28 INFO - "taskId": "HH4lVMLSRRS2kZv5gTiAWA", 03:26:28 INFO - "branch": "mozilla-central", 03:26:28 INFO - "script_repo_revision": "production", 03:26:28 INFO - "revision": "f90790f7a34616b1e878f3a6f536546e048e21e6", 03:26:28 INFO - "slavename": "talos-linux64-ix-083", 03:26:28 INFO - "repo_path": "mozilla-central" 03:26:28 INFO - } 03:26:28 INFO - Finding installer, test and symbols from parent task. 03:26:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HH4lVMLSRRS2kZv5gTiAWA'}, attempt #1 03:26:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HH4lVMLSRRS2kZv5gTiAWA'}, attempt #1 03:26:28 INFO - Task dependencies: KE1SBkzQRFq9ogOXBQsfvw 03:26:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw'}, attempt #1 03:26:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 03:26:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.test_packages.json 03:26:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.crashreporter-symbols.zip 03:26:29 INFO - Running post-action listener: _resource_record_post_action 03:26:29 INFO - [mozharness: 2017-10-01 10:26:29.400322Z] Finished read-buildbot-config step (success) 03:26:29 INFO - [mozharness: 2017-10-01 10:26:29.400541Z] Running download-and-extract step. 03:26:29 INFO - Running pre-action listener: _resource_record_pre_action 03:26:29 INFO - Running main action method: download_and_extract 03:26:29 INFO - mkdir: /builds/slave/test/build/tests 03:26:29 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:26:29 INFO - trying https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.test_packages.json 03:26:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:26:29 INFO - Downloaded 989 bytes. 03:26:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:26:29 INFO - Using the following test package requirements: 03:26:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:26:29 INFO - u'common': [u'target.common.tests.zip'], 03:26:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:26:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:26:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:26:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:26:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:26:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:26:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:26:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:26:29 INFO - u'target.web-platform.tests.tar.gz'], 03:26:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:26:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:26:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.common.tests.zip 03:26:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:26:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.common.tests.zip into memory 03:26:33 INFO - Content-Length response header: 55366723 03:26:33 INFO - Bytes received: 55366723 03:26:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.talos.tests.zip 03:26:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:26:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.talos.tests.zip into memory 03:26:45 INFO - Content-Length response header: 14522385 03:26:45 INFO - Bytes received: 14522385 03:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:45 INFO - trying https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 03:26:45 INFO - Downloading https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:26:48 INFO - Downloaded 61601117 bytes. 03:26:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 03:26:48 INFO - mkdir: /builds/slave/test/properties 03:26:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:48 INFO - Contents: 03:26:48 INFO - build_url:https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - Running post-action listener: find_tests_for_verification 03:26:48 INFO - Running post-action listener: set_extra_try_arguments 03:26:48 INFO - [mozharness: 2017-10-01 10:26:48.009661Z] Finished download-and-extract step (success) 03:26:48 INFO - [mozharness: 2017-10-01 10:26:48.009758Z] Running populate-webroot step. 03:26:48 INFO - Running pre-action listener: _resource_record_pre_action 03:26:48 INFO - Running main action method: populate_webroot 03:26:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['tresize', 03:26:48 INFO - 'tcanvasmark']}, 03:26:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['dromaeo_css', 03:26:48 INFO - 'kraken']}, 03:26:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'tests': ['damp', 'tps']}, 03:26:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['damp', 'tps']}, 03:26:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['dromaeo_dom']}, 03:26:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:26:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['basic_compositor_video', 03:26:48 INFO - 'glvideo']}, 03:26:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:26:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['ts_paint_webext', 03:26:48 INFO - 'tp5o_webext']}, 03:26:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_many_windows', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint', 03:26:48 INFO - 'cpstartup']}, 03:26:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['a11yr', 03:26:48 INFO - 'ts_paint', 03:26:48 INFO - 'tpaint', 03:26:48 INFO - 'sessionrestore', 03:26:48 INFO - 'sessionrestore_many_windows', 03:26:48 INFO - 'sessionrestore_no_auto_restore', 03:26:48 INFO - 'tabpaint', 03:26:48 INFO - 'cpstartup']}, 03:26:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:26:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:26:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['perf_reftest_singletons']}, 03:26:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['perf_reftest']}, 03:26:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:48 INFO - 'tsvgr_opacity', 03:26:48 INFO - 'tart', 03:26:48 INFO - 'tscrollx', 03:26:48 INFO - 'tsvg_static']}, 03:26:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['tsvgx', 03:26:48 INFO - 'tsvgr_opacity', 03:26:48 INFO - 'tart', 03:26:48 INFO - 'tscrollx', 03:26:48 INFO - 'tsvg_static']}, 03:26:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:26:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-stylo'], 03:26:48 INFO - 'tests': ['tp5o']}, 03:26:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:26:48 INFO - 'talos_options': ['--mitmproxy', 03:26:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:48 INFO - '--firstNonBlankPaint'], 03:26:48 INFO - 'tests': ['tp6_google', 03:26:48 INFO - 'tp6_youtube', 03:26:48 INFO - 'tp6_amazon', 03:26:48 INFO - 'tp6_facebook']}, 03:26:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:26:48 INFO - 'talos_options': ['--disable-stylo', 03:26:48 INFO - '--mitmproxy', 03:26:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:48 INFO - '--firstNonBlankPaint'], 03:26:48 INFO - 'tests': ['tp6_google', 03:26:48 INFO - 'tp6_youtube', 03:26:48 INFO - 'tp6_amazon', 03:26:48 INFO - 'tp6_facebook']}, 03:26:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:26:48 INFO - 'talos_options': ['--stylo-threads=1', 03:26:48 INFO - '--mitmproxy', 03:26:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:48 INFO - '--firstNonBlankPaint'], 03:26:48 INFO - 'tests': ['tp6_google', 03:26:48 INFO - 'tp6_youtube', 03:26:48 INFO - 'tp6_amazon', 03:26:48 INFO - 'tp6_facebook']}, 03:26:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--xperf_path', 03:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:48 INFO - 'tests': ['tp5n']}, 03:26:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:48 INFO - 'talos_options': ['--disable-stylo', 03:26:48 INFO - '--xperf_path', 03:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:48 INFO - 'tests': ['tp5n']}}} 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - [mozharness: 2017-10-01 10:26:48.027381Z] Finished populate-webroot step (success) 03:26:48 INFO - [mozharness: 2017-10-01 10:26:48.027471Z] Running create-virtualenv step. 03:26:48 INFO - Running pre-action listener: _resource_record_pre_action 03:26:48 INFO - Running main action method: create_virtualenv 03:26:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:26:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:26:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:48 INFO - Installing pip...............done. 03:26:48 INFO - Return code: 0 03:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:26:49 INFO - Reading from file tmpfile_stdout 03:26:49 INFO - Output received: 03:26:49 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:26:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26:49 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:26:49 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:26:49 INFO - Using env: {'DISPLAY': ':0', 03:26:49 INFO - 'HOME': '/home/cltbld', 03:26:49 INFO - 'LANG': 'en_US.UTF-8', 03:26:49 INFO - 'LANGUAGE': 'en_US:en', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MAIL': '/var/mail/cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SHLVL': '1', 03:26:49 INFO - 'TERM': 'linux', 03:26:49 INFO - 'TMOUT': '86400', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - '_': '/tools/buildbot/bin/python'} 03:26:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:26:50 INFO - Downloading/unpacking pip>=1.5 03:26:50 INFO - Running setup.py egg_info for package pip 03:26:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:26:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:26:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:26:50 INFO - Installing collected packages: pip 03:26:50 INFO - Found existing installation: pip 1.1 03:26:50 INFO - Uninstalling pip: 03:26:50 INFO - Successfully uninstalled pip 03:26:50 INFO - Running setup.py install for pip 03:26:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:26:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:26:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:26:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:26:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:26:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:26:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:26:50 INFO - Successfully installed pip 03:26:50 INFO - Cleaning up... 03:26:50 INFO - Return code: 0 03:26:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:50 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26:50 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:26:50 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:26:50 INFO - Using env: {'DISPLAY': ':0', 03:26:50 INFO - 'HOME': '/home/cltbld', 03:26:50 INFO - 'LANG': 'en_US.UTF-8', 03:26:50 INFO - 'LANGUAGE': 'en_US:en', 03:26:50 INFO - 'LOGNAME': 'cltbld', 03:26:50 INFO - 'MAIL': '/var/mail/cltbld', 03:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:50 INFO - 'MOZ_NO_REMOTE': '1', 03:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:50 INFO - 'NO_EM_RESTART': '1', 03:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:50 INFO - 'PWD': '/builds/slave/test', 03:26:50 INFO - 'SHELL': '/bin/bash', 03:26:50 INFO - 'SHLVL': '1', 03:26:50 INFO - 'TERM': 'linux', 03:26:50 INFO - 'TMOUT': '86400', 03:26:50 INFO - 'USER': 'cltbld', 03:26:50 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:50 INFO - '_': '/tools/buildbot/bin/python'} 03:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:50 INFO - Downloading/unpacking psutil>=3.1.1 03:26:50 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:26:50 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:26:50 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:26:50 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:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:51 INFO - Installing collected packages: psutil 03:26:51 INFO - Running setup.py install for psutil 03:26:51 INFO - building 'psutil._psutil_linux' extension 03:26:51 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:26:52 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:26:52 INFO - building 'psutil._psutil_posix' extension 03:26:52 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:26:52 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:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:52 INFO - Successfully installed psutil 03:26:52 INFO - Cleaning up... 03:26:52 INFO - Return code: 0 03:26:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26: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:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:52 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26:52 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:26:52 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:26:52 INFO - Using env: {'DISPLAY': ':0', 03:26:52 INFO - 'HOME': '/home/cltbld', 03:26:52 INFO - 'LANG': 'en_US.UTF-8', 03:26:52 INFO - 'LANGUAGE': 'en_US:en', 03:26:52 INFO - 'LOGNAME': 'cltbld', 03:26:52 INFO - 'MAIL': '/var/mail/cltbld', 03:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:52 INFO - 'MOZ_NO_REMOTE': '1', 03:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:52 INFO - 'NO_EM_RESTART': '1', 03:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:52 INFO - 'PWD': '/builds/slave/test', 03:26:52 INFO - 'SHELL': '/bin/bash', 03:26:52 INFO - 'SHLVL': '1', 03:26:52 INFO - 'TERM': 'linux', 03:26:52 INFO - 'TMOUT': '86400', 03:26:52 INFO - 'USER': 'cltbld', 03:26:52 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:52 INFO - '_': '/tools/buildbot/bin/python'} 03:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:53 INFO - Installing collected packages: mozsystemmonitor 03:26:53 INFO - Running setup.py install for mozsystemmonitor 03:26:53 INFO - Successfully installed mozsystemmonitor 03:26:53 INFO - Cleaning up... 03:26:53 INFO - Return code: 0 03:26:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:53 INFO - Using env: {'DISPLAY': ':0', 03:26:53 INFO - 'HOME': '/home/cltbld', 03:26:53 INFO - 'LANG': 'en_US.UTF-8', 03:26:53 INFO - 'LANGUAGE': 'en_US:en', 03:26:53 INFO - 'LOGNAME': 'cltbld', 03:26:53 INFO - 'MAIL': '/var/mail/cltbld', 03:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:53 INFO - 'MOZ_NO_REMOTE': '1', 03:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:53 INFO - 'NO_EM_RESTART': '1', 03:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:53 INFO - 'PWD': '/builds/slave/test', 03:26:53 INFO - 'SHELL': '/bin/bash', 03:26:53 INFO - 'SHLVL': '1', 03:26:53 INFO - 'TERM': 'linux', 03:26:53 INFO - 'TMOUT': '86400', 03:26:53 INFO - 'USER': 'cltbld', 03:26:53 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:53 INFO - '_': '/tools/buildbot/bin/python'} 03:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26: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:26: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:26: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:26: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:26:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:55 INFO - warning: no files found matching '*.txt' 03:26:55 INFO - no previously-included directories found matching 'build' 03:26:55 INFO - no previously-included directories found matching 'dist' 03:26:55 INFO - no previously-included directories found matching '.git*' 03:26:55 INFO - Installing collected packages: jsonschema, functools32 03:26:55 INFO - Running setup.py install for functools32 03:26:55 INFO - warning: no files found matching '*.txt' 03:26:55 INFO - no previously-included directories found matching 'build' 03:26:55 INFO - no previously-included directories found matching 'dist' 03:26:55 INFO - no previously-included directories found matching '.git*' 03:26:55 INFO - Successfully installed jsonschema functools32 03:26:55 INFO - Cleaning up... 03:26:55 INFO - Return code: 0 03:26:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26: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:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26: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', '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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:26: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 functools32==3.2.3-2 03:26:55 INFO - Using env: {'DISPLAY': ':0', 03:26:55 INFO - 'HOME': '/home/cltbld', 03:26:55 INFO - 'LANG': 'en_US.UTF-8', 03:26:55 INFO - 'LANGUAGE': 'en_US:en', 03:26:55 INFO - 'LOGNAME': 'cltbld', 03:26:55 INFO - 'MAIL': '/var/mail/cltbld', 03:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:55 INFO - 'MOZ_NO_REMOTE': '1', 03:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:55 INFO - 'NO_EM_RESTART': '1', 03:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:55 INFO - 'PWD': '/builds/slave/test', 03:26:55 INFO - 'SHELL': '/bin/bash', 03:26:55 INFO - 'SHLVL': '1', 03:26:55 INFO - 'TERM': 'linux', 03:26:55 INFO - 'TMOUT': '86400', 03:26:55 INFO - 'USER': 'cltbld', 03:26:55 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:55 INFO - '_': '/tools/buildbot/bin/python'} 03:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:55 INFO - Cleaning up... 03:26:55 INFO - Return code: 0 03:26:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26: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:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26: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', '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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26: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 blobuploader==1.2.4 03:26:55 INFO - Using env: {'DISPLAY': ':0', 03:26:55 INFO - 'HOME': '/home/cltbld', 03:26:55 INFO - 'LANG': 'en_US.UTF-8', 03:26:55 INFO - 'LANGUAGE': 'en_US:en', 03:26:55 INFO - 'LOGNAME': 'cltbld', 03:26:55 INFO - 'MAIL': '/var/mail/cltbld', 03:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:55 INFO - 'MOZ_NO_REMOTE': '1', 03:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:55 INFO - 'NO_EM_RESTART': '1', 03:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:55 INFO - 'PWD': '/builds/slave/test', 03:26:55 INFO - 'SHELL': '/bin/bash', 03:26:55 INFO - 'SHLVL': '1', 03:26:55 INFO - 'TERM': 'linux', 03:26:55 INFO - 'TMOUT': '86400', 03:26:55 INFO - 'USER': 'cltbld', 03:26:55 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:55 INFO - '_': '/tools/buildbot/bin/python'} 03:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26: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:26: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:26: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:26: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:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26: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:26: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:26: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:26: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:26:57 INFO - Downloading docopt-0.6.1.tar.gz 03:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:58 INFO - Running setup.py install for blobuploader 03:26:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:58 INFO - Running setup.py install for requests 03:26:58 INFO - Running setup.py install for docopt 03:26:58 INFO - Successfully installed blobuploader requests docopt 03:26:58 INFO - Cleaning up... 03:26:58 INFO - Return code: 0 03:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:58 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:26:58 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:26:58 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:26:58 INFO - Using env: {'DISPLAY': ':0', 03:26:58 INFO - 'HOME': '/home/cltbld', 03:26:58 INFO - 'LANG': 'en_US.UTF-8', 03:26:58 INFO - 'LANGUAGE': 'en_US:en', 03:26:58 INFO - 'LOGNAME': 'cltbld', 03:26:58 INFO - 'MAIL': '/var/mail/cltbld', 03:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:58 INFO - 'MOZ_NO_REMOTE': '1', 03:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:58 INFO - 'NO_EM_RESTART': '1', 03:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:58 INFO - 'PWD': '/builds/slave/test', 03:26:58 INFO - 'SHELL': '/bin/bash', 03:26:58 INFO - 'SHLVL': '1', 03:26:58 INFO - 'TERM': 'linux', 03:26:58 INFO - 'TMOUT': '86400', 03:26:58 INFO - 'USER': 'cltbld', 03:26:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:58 INFO - '_': '/tools/buildbot/bin/python'} 03:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 INFO - Running setup.py (path:/tmp/pip-0Q2ux9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 INFO - Running setup.py (path:/tmp/pip-ynmnuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 INFO - Running setup.py (path:/tmp/pip-synHMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 INFO - Running setup.py (path:/tmp/pip-8ouUwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:59 INFO - Running setup.py (path:/tmp/pip-Sv2Aad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 INFO - Running setup.py (path:/tmp/pip-z7JrFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 INFO - Running setup.py (path:/tmp/pip-GNJ5yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 INFO - Running setup.py (path:/tmp/pip-g8w6H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:59 INFO - Running setup.py (path:/tmp/pip-NMM8N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:59 INFO - Running setup.py (path:/tmp/pip-cXKS0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:59 INFO - Running setup.py (path:/tmp/pip-8xpjH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:59 INFO - Running setup.py (path:/tmp/pip-PQVK4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 INFO - Running setup.py (path:/tmp/pip-DiGNuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:00 INFO - Running setup.py (path:/tmp/pip-JHXNPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:00 INFO - Running setup.py (path:/tmp/pip-SHDEzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:00 INFO - Running setup.py (path:/tmp/pip-p0bbCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:00 INFO - Running setup.py (path:/tmp/pip-CRbn7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:00 INFO - Running setup.py install for manifestparser 03:27:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozcrash 03:27:00 INFO - Running setup.py install for mozdebug 03:27:00 INFO - Running setup.py install for mozdevice 03:27:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozfile 03:27:00 INFO - Running setup.py install for mozhttpd 03:27:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozinfo 03:27:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozInstall 03:27:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozleak 03:27:01 INFO - Running setup.py install for mozlog 03:27:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for moznetwork 03:27:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozprocess 03:27:01 INFO - Running setup.py install for mozprofile 03:27:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozrunner 03:27:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozscreenshot 03:27:01 INFO - Running setup.py install for moztest 03:27:02 INFO - Running setup.py install for mozversion 03:27:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:02 INFO - Cleaning up... 03:27:02 INFO - Return code: 0 03:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:02 INFO - Using env: {'DISPLAY': ':0', 03:27:02 INFO - 'HOME': '/home/cltbld', 03:27:02 INFO - 'LANG': 'en_US.UTF-8', 03:27:02 INFO - 'LANGUAGE': 'en_US:en', 03:27:02 INFO - 'LOGNAME': 'cltbld', 03:27:02 INFO - 'MAIL': '/var/mail/cltbld', 03:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:02 INFO - 'MOZ_NO_REMOTE': '1', 03:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:02 INFO - 'NO_EM_RESTART': '1', 03:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:02 INFO - 'PWD': '/builds/slave/test', 03:27:02 INFO - 'SHELL': '/bin/bash', 03:27:02 INFO - 'SHLVL': '1', 03:27:02 INFO - 'TERM': 'linux', 03:27:02 INFO - 'TMOUT': '86400', 03:27:02 INFO - 'USER': 'cltbld', 03:27:02 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:02 INFO - '_': '/tools/buildbot/bin/python'} 03:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:02 INFO - Running setup.py (path:/tmp/pip-mPv6so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 INFO - Running setup.py (path:/tmp/pip-ON11HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Running setup.py (path:/tmp/pip-FUv_M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Running setup.py (path:/tmp/pip-ra53YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:02 INFO - Running setup.py (path:/tmp/pip-pUU2zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 INFO - Running setup.py (path:/tmp/pip-1jSWGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 INFO - Running setup.py (path:/tmp/pip-FDVLeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 INFO - Running setup.py (path:/tmp/pip-d651jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 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:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:02 INFO - Running setup.py (path:/tmp/pip-OeXQUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:03 INFO - Running setup.py (path:/tmp/pip-J5_cH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:03 INFO - Running setup.py (path:/tmp/pip-d57PpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 INFO - Running setup.py (path:/tmp/pip-mRgGyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 INFO - Running setup.py (path:/tmp/pip-9xMvg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 INFO - Running setup.py (path:/tmp/pip-gXQWo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 INFO - Running setup.py (path:/tmp/pip-JwdIVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:03 INFO - Running setup.py (path:/tmp/pip-p9cFE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:03 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:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:03 INFO - Running setup.py (path:/tmp/pip-Decb1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:03 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:27:03 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:27:03 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:27:03 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:27:03 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:27:03 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:27:03 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:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27: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:27: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:27: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:27: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:27:04 INFO - Downloading blessings-1.6.tar.gz 03:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:05 INFO - Installing collected packages: blessings 03:27:05 INFO - Running setup.py install for blessings 03:27:05 INFO - Successfully installed blessings 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:05 INFO - Reading from file tmpfile_stdout 03:27:05 INFO - Current package versions: 03:27:05 INFO - argparse == 1.2.1 03:27:05 INFO - blessings == 1.6 03:27:05 INFO - blobuploader == 1.2.4 03:27:05 INFO - docopt == 0.6.1 03:27:05 INFO - functools32 == 3.2.3-2 03:27:05 INFO - jsonschema == 2.5.1 03:27:05 INFO - manifestparser == 1.1 03:27:05 INFO - mozInstall == 1.13 03:27:05 INFO - mozcrash == 1.0 03:27:05 INFO - mozdebug == 0.1 03:27:05 INFO - mozdevice == 0.51 03:27:05 INFO - mozfile == 1.2 03:27:05 INFO - mozhttpd == 0.7 03:27:05 INFO - mozinfo == 0.10 03:27:05 INFO - mozleak == 0.1 03:27:05 INFO - mozlog == 3.5 03:27:05 INFO - moznetwork == 0.27 03:27:05 INFO - mozprocess == 0.25 03:27:05 INFO - mozprofile == 0.28 03:27:05 INFO - mozrunner == 6.13 03:27:05 INFO - mozscreenshot == 0.1 03:27:05 INFO - mozsystemmonitor == 0.3 03:27:05 INFO - moztest == 0.8 03:27:05 INFO - mozversion == 1.4 03:27:05 INFO - psutil == 3.1.1 03:27:05 INFO - requests == 1.2.3 03:27:05 INFO - wsgiref == 0.1.2 03:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:05 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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:05 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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:05 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:27:05 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:27:05 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:27:05 INFO - Using env: {'DISPLAY': ':0', 03:27:05 INFO - 'HOME': '/home/cltbld', 03:27:05 INFO - 'LANG': 'en_US.UTF-8', 03:27:05 INFO - 'LANGUAGE': 'en_US:en', 03:27:05 INFO - 'LOGNAME': 'cltbld', 03:27:05 INFO - 'MAIL': '/var/mail/cltbld', 03:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:05 INFO - 'MOZ_NO_REMOTE': '1', 03:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:05 INFO - 'NO_EM_RESTART': '1', 03:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:05 INFO - 'PWD': '/builds/slave/test', 03:27:05 INFO - 'SHELL': '/bin/bash', 03:27:05 INFO - 'SHLVL': '1', 03:27:05 INFO - 'TERM': 'linux', 03:27:05 INFO - 'TMOUT': '86400', 03:27:05 INFO - 'USER': 'cltbld', 03:27:05 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:05 INFO - '_': '/tools/buildbot/bin/python'} 03:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27:05 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:27:05 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:27:05 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:27:05 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:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:27:06 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:27:06 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:27:06 INFO - Installing collected packages: simplejson 03:27:06 INFO - Running setup.py install for simplejson 03:27:06 INFO - building 'simplejson._speedups' extension 03:27:06 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:27:07 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:27:07 INFO - Successfully installed simplejson 03:27:07 INFO - Cleaning up... 03:27:07 INFO - Return code: 0 03:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27: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:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:07 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 0x10481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1210b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', '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:27:07 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:27:07 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:27:07 INFO - Using env: {'DISPLAY': ':0', 03:27:07 INFO - 'HOME': '/home/cltbld', 03:27:07 INFO - 'LANG': 'en_US.UTF-8', 03:27:07 INFO - 'LANGUAGE': 'en_US:en', 03:27:07 INFO - 'LOGNAME': 'cltbld', 03:27:07 INFO - 'MAIL': '/var/mail/cltbld', 03:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:07 INFO - 'MOZ_NO_REMOTE': '1', 03:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:07 INFO - 'NO_EM_RESTART': '1', 03:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:07 INFO - 'PWD': '/builds/slave/test', 03:27:07 INFO - 'SHELL': '/bin/bash', 03:27:07 INFO - 'SHLVL': '1', 03:27:07 INFO - 'TERM': 'linux', 03:27:07 INFO - 'TMOUT': '86400', 03:27:07 INFO - 'USER': 'cltbld', 03:27:07 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:07 INFO - '_': '/tools/buildbot/bin/python'} 03:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:08 INFO - Cleaning up... 03:27:08 INFO - Return code: 0 03:27:08 INFO - Running post-action listener: _resource_record_post_action 03:27:08 INFO - Running post-action listener: _start_resource_monitoring 03:27:08 INFO - Starting resource monitoring. 03:27:08 INFO - [mozharness: 2017-10-01 10:27:08.094773Z] Finished create-virtualenv step (success) 03:27:08 INFO - [mozharness: 2017-10-01 10:27:08.095305Z] Running install step. 03:27:08 INFO - Running pre-action listener: _resource_record_pre_action 03:27:08 INFO - Running main action method: install 03:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:08 INFO - Reading from file tmpfile_stdout 03:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:08 INFO - Reading from file tmpfile_stdout 03:27:08 INFO - Output received: 03:27:08 INFO - Usage: mozinstall [options] installer 03:27:08 INFO - Options: 03:27:08 INFO - -h, --help show this help message and exit 03:27:08 INFO - -d DEST, --destination=DEST 03:27:08 INFO - Directory to install application into. [default: 03:27:08 INFO - "/builds/slave/test"] 03:27:08 INFO - --app=APP Application being installed. [default: firefox] 03:27:08 INFO - mkdir: /builds/slave/test/build/application 03:27:08 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:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:27:26 INFO - Reading from file tmpfile_stdout 03:27:26 INFO - Output received: 03:27:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:26 INFO - Running post-action listener: _resource_record_post_action 03:27:26 INFO - [mozharness: 2017-10-01 10:27:26.242012Z] Finished install step (success) 03:27:26 INFO - [mozharness: 2017-10-01 10:27:26.242265Z] Running setup-mitmproxy step. 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running main action method: setup_mitmproxy 03:27:26 INFO - Skipping: mitmproxy is not required 03:27:26 INFO - Running post-action listener: _resource_record_post_action 03:27:26 INFO - [mozharness: 2017-10-01 10:27:26.243416Z] Finished setup-mitmproxy step (success) 03:27:26 INFO - [mozharness: 2017-10-01 10:27:26.243636Z] Running run-tests step. 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running pre-action listener: _set_gcov_prefix 03:27:26 INFO - Running main action method: run_tests 03:27:26 WARNING - Try message not found. 03:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:26 INFO - Python 2.7.3 03:27:26 INFO - Return code: 0 03:27:26 INFO - grabbing minidump binary from tooltool 03:27:26 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:27:26 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 0x13b2d60>, '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 0x13b3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b3ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:26 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:27:26 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:27:26 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:27:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:26 INFO - Return code: 0 03:27:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:26 INFO - ENV: RUST_BACKTRACE is now full 03:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:26 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/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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:27:26 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/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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:27:26 INFO - Using env: {'DISPLAY': ':0', 03:27:26 INFO - 'HOME': '/home/cltbld', 03:27:26 INFO - 'LANG': 'en_US.UTF-8', 03:27:26 INFO - 'LANGUAGE': 'en_US:en', 03:27:26 INFO - 'LOGNAME': 'cltbld', 03:27:26 INFO - 'MAIL': '/var/mail/cltbld', 03:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:26 INFO - 'MOZ_NO_REMOTE': '1', 03:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:26 INFO - 'NO_EM_RESTART': '1', 03:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:26 INFO - 'PWD': '/builds/slave/test', 03:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:26 INFO - 'RUST_BACKTRACE': 'full', 03:27:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:27:26 INFO - 'SHELL': '/bin/bash', 03:27:26 INFO - 'SHLVL': '1', 03:27:26 INFO - 'TERM': 'linux', 03:27:26 INFO - 'TMOUT': '86400', 03:27:26 INFO - 'USER': 'cltbld', 03:27:26 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:26 INFO - '_': '/tools/buildbot/bin/python'} 03:27:26 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/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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:27:26 INFO - mozversion application_buildid: 20171001093509 03:27:26 INFO - mozversion application_changeset: f90790f7a34616b1e878f3a6f536546e048e21e6 03:27:26 INFO - mozversion application_display_name: FirefoxNightly 03:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:26 INFO - mozversion application_name: Firefox 03:27:26 INFO - mozversion application_remotingname: firefox 03:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:27:26 INFO - mozversion application_vendor: Mozilla 03:27:26 INFO - mozversion application_version: 58.0a1 03:27:26 INFO - mozversion platform_buildid: 20171001093509 03:27:26 INFO - mozversion platform_changeset: f90790f7a34616b1e878f3a6f536546e048e21e6 03:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:27:26 INFO - mozversion platform_version: 58.0a1 03:27:26 INFO - using testdate: 1506853646 03:27:26 INFO - actual date: 1506853646 03:27:26 INFO - starting webserver on 'localhost:44020' 03:27:26 INFO - SUITE-START | Running 2 tests 03:27:26 INFO - TEST-START | dromaeo_css 03:27:26 INFO - Initialising browser for dromaeo_css test... 03:27:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44020/getInfo.html -profile /tmp/tmp7nckjP/profile 03:27:26 INFO - TEST-INFO | started process 32093 (/builds/slave/test/build/application/firefox/firefox http://localhost:44020/getInfo.html) 03:27:31 INFO - TEST-INFO | 32093: exit 0 03:27:31 INFO - Browser initialized. 03:27:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:31 INFO - Using env: {'DISPLAY': ':0', 03:27:31 INFO - 'HOME': '/home/cltbld', 03:27:31 INFO - 'JSGC_DISABLE_POISONING': '1', 03:27:31 INFO - 'LANG': 'en_US.UTF-8', 03:27:31 INFO - 'LANGUAGE': 'en_US:en', 03:27:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:27:31 INFO - 'LOGNAME': 'cltbld', 03:27:31 INFO - 'MAIL': '/var/mail/cltbld', 03:27:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:31 INFO - 'MOZ_CRASHREPORTER': '1', 03:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:27:31 INFO - 'MOZ_NO_REMOTE': '1', 03:27:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:31 INFO - 'NO_EM_RESTART': '1', 03:27:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:31 INFO - 'PWD': '/builds/slave/test', 03:27:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:31 INFO - 'RUST_BACKTRACE': 'full', 03:27:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:27:31 INFO - 'SHELL': '/bin/bash', 03:27:31 INFO - 'SHLVL': '1', 03:27:31 INFO - 'STYLO_FORCE_DISABLED': '1', 03:27:31 INFO - 'TERM': 'linux', 03:27:31 INFO - 'TMOUT': '86400', 03:27:31 INFO - 'USER': 'cltbld', 03:27:31 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:31 INFO - '_': '/tools/buildbot/bin/python'} 03:27:31 INFO - TEST-INFO | started process 32328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7nckjP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:32 INFO - PID 32328 | 03:27:32 INFO - PID 32328 | (/builds/slave/test/build/application/firefox/firefox:32378): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:27:32 INFO - PID 32328 | 03:27:43 INFO - PID 32328 | RSS: Main: 153882624 03:27:43 INFO - PID 32328 | 03:30:40 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44020/tests/dromaeo/cssquery-ext.html) 03:30:41 INFO - PID 32328 | RSS: Main: 150278144 03:30:41 INFO - PID 32328 | 03:33:43 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-ext.html (next: http://localhost:44020/tests/dromaeo/cssquery-jquery.html) 03:33:44 INFO - PID 32328 | RSS: Main: 150196224 03:33:44 INFO - PID 32328 | 03:36:46 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44020/tests/dromaeo/cssquery-mootools.html) 03:36:46 INFO - PID 32328 | RSS: Main: 153190400 03:36:46 INFO - PID 32328 | 03:39:48 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44020/tests/dromaeo/cssquery-prototype.html) 03:39:48 INFO - PID 32328 | RSS: Main: 152313856 03:39:48 INFO - PID 32328 | 03:42:52 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44020/tests/dromaeo/cssquery-yui.html) 03:42:52 INFO - PID 32328 | RSS: Main: 155295744 03:42:52 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | Cycle 1(1): loaded http://localhost:44020/tests/dromaeo/cssquery-yui.html (next: http://localhost:44020/tests/dromaeo/cssquery-dojo.html) 03:45:54 INFO - PID 32328 | RSS: Main: 157192192 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | __start_tp_report 03:45:54 INFO - PID 32328 | _x_x_mozilla_page_load 03:45:54 INFO - PID 32328 | _x_x_mozilla_page_load_details 03:45:54 INFO - PID 32328 | |i|pagename|runs| 03:45:54 INFO - PID 32328 | |0;dojo.html;3166.809991400516;3195.0734287056753;3214.212517933107;3252.0406480088373;3253.6746325367453;6192.349803270654;6200.410960958713;6215.62706237626;6326.367363263671;6347.396997285262;6240.719167637456;6264.467520260783;6267.37326267373;6292.590981586205;6343.619382837033;5746.425357464262;5797.855053623651;5836.5914385993;5839.824805255849;5897.705114744245;5619.381867994538;5820.796272130477;5926.4073592640825;5954.970225148868;5976.8505787355225;5315.627906046579;5677.801276955287;5798.681072541009;5823.825285241471;5867.090600956859;5775.989201889694;5803.419658034205;5855.677937713424;5865.208196893407;5893;5637.661740295595;5706.4864162225185;5761.711914404263;5835.183074369592;5835.883282334372;6296.68516574174;6325.810225693191;6331.873362532723;6339.683015849235;6359.173307470046;6726.293739157367;6742.157230346207;6815.045893574904;6844.041834143224;6852.862942741167;6688.565243259172;6791.320867913169;6810.284920083419;6885.1049363582915;6896.724131034753;6285.497160227171;6295.5907865988565;6298.055291706235;6304.369563043705;6316.2736285326855;6889.173299204027;6905.413039891666;6916.446684265246;6980.511364204457;6999.580025198505;6560.901586476207;6596.505262105361;6640.369164929421;6653.168353955755;6664.700088496029;6738.225104113089;6739.932600674028;6810.421114205249;6812.182538095461;6818.659067046727;6712.228093769181;6720.630365329856;6756.932430675631;6777.457803375718;6779.389854913082;6645.833854153685;6744.224414192333;6751.223609284897;6846.931530684729;6852.074969879002;5207.973960130251;5232.03207406631;5284.180951952453;5351.625386222927;5351.812686555952;4611.677182597253;4650.441946966318;4672;4689.554492323224;4709.175894218498;5776;5867.794627188114;5870.295564532284;5891.587588868738;5902.380250073767;6563.474922006228;6761.898571521431;6764.5603035802515;6789.490788190906;6820.693068811816;5737.196792448977;5740.225069615632;5754.251947246915;5756;5763.366029736726;5803.245578074823;5816.360200377955;5827.3007239131575;5839.182514447981;5850.795222167204;6402.231732192166;6500.154979852589;6510.837229069217;6554;6589.571677840925;6711.295313992058;6764.2559318475915;6782.355676210752;6785.558938668971;6786.21958474762;6413.967930160506;6424.164858568356;6431.549791514736;6508.869822603427;6511.153550038464;6480.740770369321;6653.767118150841;6733.562318449285;6754.3921047106;6756.662166891734;6752.628605426748;6757.459403247827;6760.898586521108;6768.796936091925;6771.187457505131;6497.090407342881;6499.837504062436;6503.44720698727;6504.512161587994;6506.804795856132;6413.198350206224;6485.124508191334;6598.406143447113;6598.538102332791;6630.204375474781;6475.061116138228;6476.902846457401;6544.5418820684;6572.539922205591;6572.8356791080605;6433.903491447539;6591.901121483085;6597.637129957899;6700.899486507608;6712.2616512184595;6345.587536810092;6387.552871298964;6441.194850643669;6455.741770329134;6476.028595710681 03:45:54 INFO - PID 32328 | |1;ext.html;854.645322191291;882.8322618702446;907.7004588485801;912.5346073502511;913.7578541686454;39712.602873971286;42090.78954605226;42125.78937105314;42176.36735448971;42271.365929511085;37725.43411848824;38026.619733802654;38159.618403815955;38227.42658860113;38499.23001539968;7273;7388.963055184717;7398.408127349826;7402.29678180572;7412.407007439392;7287.8542429151385;7359.043324367824;7369.410447164214;7376.889346659805;7383.48315617907;7350.11798584168;7351.558906465602;7947.642356093989;8163.265306122448;8184.386171037167;8102.230288122619;8169.754907352789;8172.509649421054;8174.100848906615;8175.14161013097;7544.8113797154965;7842.372610191171;7967.402444816604;8031.518108913426;8062.475939064001;37522;38188.23623527514;38267.8086609568;38361.616383836365;38397.232055358734;3509.982450087733;3557.2707594942976;3579.0336609115393;3579.176789338441;3579.731520136;31378.843105784326;31630;31793.205169870707;31982.840085799424;31996.8801091963;5123.2827404163445;5160.870978225575;5163.122269214243;5193;5220.712860792655;197149;197206;197450;197633;198036;48415.273770893466;48644.51355486471;48723.75638121787;48760.51239487631;48930.755346223756;51258;51349.22976155286;51509.48490515122;51520.13598980092;51553.22670159875;15620.453284135001;15765.763513547307;15791.21043947798;15815.683686326209;15897.205139742966;12929.224246545238;12975.286359250144;13007.804882926765;13033.283169425773;13047.478100875858;13441.865581344256;13584.456621735217;13589.592312230649;13649.795253071212;13738.793918091236;5676.744546495418;5751.712414379264;5817.44734250254;5836.737346819404;5841.970790146022;984.9064338887795;989.9208063354914;1002.3735165521549;1013.4831236069657;1015.3552494166257;22754.544909101725;22810.42973925665;22857.31428057161;22866.771332286466;22891.885540572523;1092.180864351736;1093.475131936659;1102.6747109602686;1110.9611163609236;1111.261011427408;12037.277763334228;12108.515659373526;12214.938925305316;12245.877541224652;12331.50673973049;222629;222845;223367.5326493461;223981;226072;53159;53549.1967620486;55107.72446137744;56070.71964640151;56453.71773141108;1403.5228022472204;1430.6780974280703;1434.938145772121;1437.6549628089183;1438.0365155345944;26074.478510430064;26090.478190435704;26107.608385874606;26331.736682632927;26997.59503607487;35932.820335898155;36137.27725445424;36217.63782362143;36227.45658815173;36257.45613815848;197488;199069;199248;199305;199443;31928.68071319257;32126.83936580302;32219.35561288808;32234.516482253253;32252.19369515781;38580.614193858826;40258.396124058745;40468;41157.382639259835;41223.793881030404;30203.546946795377;30488;30658.84670576633;30942;30966.845165774026;29844.701552984192;30100.84949575238;30139;30379.392412152076;30475.2381190472;34237.657623423445;34647.82676086603;34770.65229347775;34990.47514287237;35055.29889402249;29316.56025159667;29720.851395742884;29780;29882.701172987992;30018;22315.888420557792;22389.66415503736;22707;22978.770212298332;23322.76677233206 03:45:54 INFO - PID 32328 | |2;jquery.html;577.232281066182;586.9207656966308;590.1148277583624;592.9851753706154;599.4994179859817;22438.102475900963;23276.41808954777;23316.533669326604;23335.649965250534;23336;24169.63745543814;24889.12888048919;24949.750502494968;25021.74891255439;25027.24918252451;6583.177102862154;6637.303083176269;6685.264620891722;6686.264510903797;6689.264180940093;6277.654728989904;6539.64031978241;6590.5716128451495;6640.435562977153;6640.800775976729;6417.165768450095;6521.869562608745;6527.608343499382;6529.412352888239;6530.249021362532;6386.552941294111;6397.296297407282;6522.15212022434;6525.249596296439;6535.673216339164;5886.352501224862;6088.086786981989;6137.324894261627;6137.60105593135;6152.815415537541;28343.716562834314;28625.14124576266;28703.56944645832;28852.711472885214;28906.566401503995;1976.663967125592;2005.0977060322914;2016.8184863362221;2017.8991050447567;2021.1006102284489;17919.1936362864;18240.361587344378;18445.815541844542;18464.63070738578;18507.2597096116;2470.8641024743633;2473.7773600376054;2497.725250222474;2501.962470562943;2502.862342571158;126394.36802815927;132234;142570;150885;151041;14712.632184195267;14911.812132134635;15086.14015195032;15212.011219270711;15583.844161558465;23971.760282397303;24016.39959001039;24047.398815029414;24071.518569628508;24119.879400602884;10315.690529284133;10407.115395191342;10426.635067772591;10480.371177729361;10495.845456999725;9547.899462118323;9558.61765529371;9598.232141428669;9607.663731769495;9654.372465789702;9051.14014168653;9131.908680913239;9149.222316103072;9301.302402319718;9408.388454750419;2692.7576518113074;2755.4626847764494;2785.359367345522;2874.152125123094;2895.406441679451;943.4290860779649;961.7547525381123;966.3622009473854;973.0707174648194;974.8440249560036;18998;19062.61874762497;19381.321653742052;19542.902285488482;19602.803971960384;1030.8969701808378;1037.6005237983431;1049.522467277387;1056.6882769582992;1063.8936106389453;10389.168866490663;10475.528601212964;10740.570377184982;10767.946160269148;10825.621103261348;464969;465707;476769;481955;482664;124195.37902310431;124219;127706;128691;128974.35512822376;1049.9895001050045;1073.672529878379;1165.3823473559028;1203.3983008495752;1204.313541281461;20008.199672012957;20327.695084573446;20403.59192816165;20505.2823151189;20745.377638670863;55904.72047639736;56080.15879761725;56614.433855662566;56736.14895776649;57541.71229143828;70514.64742676253;71805;72107.91838122538;72463;72625.27374726185;14242.786358204843;14545.490907818175;14604.269786510844;14610.196439195946;14635.195064271567;21274;21695.34913952584;22580.548389032458;22903.770962290164;23123.2657550681;18135.183916723516;18137.727934081264;18169.273229070688;18398.356057537923;18586.163622636745;15806.340334265196;16466.917665411594;16512.42206522766;16708.164591770605;17219.311227551258;17865.374711885022;18656.626867462302;18731.625367492845;18929.864208147555;18938.337158199396;14454.349554270293;14461.276936152939;14630.926845366132;14636.85363146355;14641.194734289717;17296.91351543234;17332.39336623212;17436.47690569285;17493.212805423533;17493.562660933578 03:45:54 INFO - PID 32328 | |3;mootools.html;1323.3118778235319;1411.7811739180424;1414.6251243420502;1417.0222546442953;1419.801227828104;14508.492202772904;15100.924495377521;15102.546923592283;15116.848831511696;15117.244137793094;14727.337269822858;14898.925505372457;14905.776413353782;14944.327505262263;14968.101913885175;2698.0961377938365;2810.943781124376;2814.408974115438;2817.09852847089;2818.929526761837;2719.3881376690283;2780.2771279467283;2797.482465743834;2799.0902956539103;2799.5800629905575;2696.1776658119265;2776.694563598003;2799.4401119776126;2807.3402750353653;2807.4946509628257;2746.725327467257;2795.11953734574;2821.7883658725677;2825.3219227385384;2827.406244688618;2710.850903200323;2809.1993781772303;2825.773938084969;2827.9010234641896;2828.7312705292966;14626.853731462656;14655.926720366437;14669.853301466956;14770.630734231623;14810;7528.247175282483;7807.96096019522;7840.4511684182135;7851.646675899598;7871.330936870373;4979.278004689336;5190.377154741417;5342.385625653061;5429.212764149176;5515.862103447446;1942.9417117486498;1953.716711076886;1998.2406685459578;2012.7081573171808;2025.6151331247015;24939.251822445356;25206.621900671504;25235.369115772068;25241.747582524124;25269.368265793317;6556.409923106848;6560.737570497222;6613.900791488131;6687.398134167851;6755.2231493378895;16117.435889743803;16247.59381015484;16297.674046519003;16815.57961050959;17217.139143042798;7527;7893.960530197312;7895.171007044178;7896.289333959856;7896.565688887166;7010.334018268256;7030.261822508665;7054.92945070553;7246.275372462712;7305.853882922418;5083.212102124176;5281.260623512711;5283.682979021194;5290.68255904647;5297.761600727977;1539.4304107480305;1544.5675210940954;1546.304163126575;1556.4630202580092;1557.9922100389426;896.3725392225468;927.9118483744033;936.9812603748023;939.3847030195233;944.1408318430196;7658.2724641159;7784.805379865548;7806.375489960789;7810.6875724971505;7858.449908506464;716.8458781362032;718.4252597921642;731.5098883747902;733.5635296998278;738.6639079218943;4840.959193773285;5235;5544.417836127229;5601.719914004283;5728.51307638847;20588.794112058986;20623.793762062487;20892.47768805792;21050.78949210519;21448.892755536122;19260.229590816492;20616.484587885123;21051.368458946257;21066.47333816667;21132.366029019155;11103.222774405876;11106.389148596905;11115.83326250107;11166.609168679057;11216.766155722864;8088.636011379384;8390.874136888073;8500.70247541333;8544.2310192083;8634.266087382643;17509.21208545593;17567;17904.28382864723;17974.820251797315;18185;18336.266549337877;18405.53986150357;18468.353607623667;18528.44414667562;18640.533986649898;10931.45342732876;11154.776904462027;11173.162012848907;11177.161712871404;11183.888161118284;13525.64743525679;13593.252371119683;13728;13749.518766843112;13767.242801646005;11223.60717374888;11293.887061129284;11301.886981130083;11653.417329133339;11681.824772628248;11054.944725276322;11227.101831853268;11253.549858005588;11413.657590272305;11526.1931664786;9904.851427228741;9917.603295868084;10045.949770251102;10065.69802905914;10070.144037756872;7322.1579518356075;7454.254574542502;7466.701331946661;7496.887546686695;7576.431767617561;7677.462577619513;7695.307422332017;7701.345385642283;7786.4160187985;7859.292663660298 03:45:54 INFO - PID 32328 | |4;prototype.html;501.829378011476;502.3594916481483;533.346650353317;533.9919901201481;540.9837704868855;6303.653299068549;6314.526410519206;6353.555251132422;6418;6463.967680161604;6281.591696539722;6283.026130949699;6284.177588499341;6336.651484168369;6374.203224596926;5267.341582302212;5294;5308.885134121839;5316.149416093426;5319.148936170213;4916.115099282128;5240.266362709223;5264.157734762439;5317.707526086064;5360.249565060894;4987.800487980477;5023.447420783729;5049.2173713074535;5060.215666571669;5073.873153171182;5063.265826455144;5083.551187911427;5090.1855703087695;5090.694558326494;5104.285400043978;4495.842645507424;4571.6114130298965;4582.1064892346;4595;4600.4479462464715;6012.158297838306;6233.532485063638;6234.3453937336835;6256.311805701369;6257.124002639589;5695.886082278331;5818.970905145489;5821.912671309934;5834.795782147605;5863.459031215503;6688.699008544627;6707;6727.96322206677;6737.831554211135;6761.701021652612;4795.889808484256;5001.774920128603;5006.799728010875;5022.748862556858;5027.49725027498;6555.573887697285;6761.039298603399;6785.558938668971;6904.447644188453;6938.5836849789175;5013.222950442687;5017.623678224148;5023.572996295356;5064.974675126675;5077.720725360066;5059.747012649353;5075;5134.948650513522;5147.3051138096625;5190.8183213587345;5747.3677895431465;5801.7389217485315;5802.883942321215;5804.448577385142;5826.388229235954;6487.967560162263;6524.804255872332;6615.37153970372;6619.569727967667;6690.765823196165;1758.261530157337;1796.4790210838971;1797.4877160009335;1800.5588630785542;1812.392848395776;1210.1452468020675;1243.5398902406168;1247.9188852724726;1248.8635341838883;1265.2282107914166;5688.999999999917;5694.174344719992;5726.541876649858;5750.913736293959;5874.823755287348;6685.866282674319;6757.493188010919;6816.488763342769;6845.178578570603;6872.896906546406;5783.363829978699;5876;5878.676672783038;5912.497437717842;5921.496672782861;3593.9281214376088;3606.1705807664384;3617.3488772020764;3637.3634613942454;3655.670989610948;6332.778352757631;6528.51036172289;6557.967210163919;6609.140811694545;6669.032990216391;6962.686679099453;6977.965110174417;7017.052697885822;7020.333068358498;7038.92961070393;6418.645540914367;6438.937575300117;6446.355364463516;6597.835054123685;6605.273419923805;6728.73085076611;6796.150481189851;6800.82997925036;6810.250872404131;6826.293426643339;6736.360045795642;6740.325967403221;6742.359475849787;6767.864642707217;6785.219699734594;6483.967580162069;6493.350664933658;6495.415412612888;6514.185726784152;6568.573042752206;5123.5644970177955;5124.12889808726;5127.3847138343635;5127.4872512748425;5178.8964220716125;6466.902996454963;6642.368974947372;6789.422899053438;6896.379325860697;6911.619860907698;6381.361863813581;6557.885159522797;6587.209534855848;6640.369164929324;6659.667016649245;6524.249711283263;6573;6606.53754237218;6650.534462587572;6659.334066593496;6421.64680942534;6441.743859947265;6492.48060155177;6552.3447655236005;6563.671816409065;6547.639879806466;6636.369544893228;6687.929931210982;6741.764038258638;6756.493263005196;6391.552591318563;6454.225492940877;6475.5318830007145;6512.837179070371;6528.804135875931 03:45:54 INFO - PID 32328 | |5;yui.html;897.6947837735169;917.3761841947476;925.2551695884814;928.3316012471018;939.0327962198935;17077.37764912333;17846.910765446188;17907.373241936533;18050.5487362816;18075.09624518774;18721.90639046803;18885.150168242428;18921.62156756864;18925.716114258295;18958.146883390247;953.1136043479561;953.532768943218;959.8704174936399;959.8848138223389;961.8941916389192;976.7069879036296;977.8777652793401;978.5107446276861;978.7161723100328;982.0572250639394;990.2424645146468;1026.2046913641911;1029.907308342249;1031.5358088860005;1031.6286136990677;1010.6967909627083;1014.4420568687193;1016.0398423489805;1016.8881423043459;1022.0137567247605;717.9533330333512;736.517580984456;739.7669734033763;746.7199800074972;753.7135888362387;18947.33684321042;19166.712499312383;19171.32900348481;19183.90408047965;19236.422907312663;21543.784562154335;21571.352859414244;22252.888735556382;22467.887660561755;22494.77505224943;15683.137427441487;15772;15907.20463976808;16083.276252568663;16131.435399761069;3734.589195188527;3762.435634654796;3766.8681596144;3770.679492243135;3773.339665558544;105049.2260910751;138395;144092;144141;145583;17964.91017544904;18308;18393.448196554124;18524.629507409776;18524.814751852307;32320;33166.502502462485;33459.49810752841;33469.49795753066;33513.162170945434;9320.347575669639;9470.14768670823;9728.270379721549;9758.46328451942;9791.755206119904;4526.569975852354;4570.840020599263;4586.770661466913;4600.332951721982;4600.7929643166135;5408.756605952742;5485.710857948379;5509.256250406224;5541.141123125922;5576.972115139399;1106.336198281041;1112.2547892911768;1129.412705393191;1132.1565433751907;1139.0602752729033;674.7098747538605;678.375894177358;690.8031211104811;696.1089805049545;708.5606923707231;11858.881411185777;11982;12138.27170369763;12235.95994340491;12452.937735311447;693.0712844788009;697.1425147069133;697.2042111134388;704.8977898204731;717.587387252332;5789.594728369058;5939.524838013035;5941.910871336933;5954.4045595440975;6019.428154325332;127494.72505275015;127920.36039819928;128656.35671821768;129187;132452;107666;108758;110517;112699;115743.42128289305;99135.50432247936;99261;101333;102807;104238.478807607;11620.6513804586;11652.53389864396;12017.759644807229;12064.396780160781;12399.814002789784;44233;45199;46016.309755353024;46191;46859.297110542684;80047;81726.59136704278;83927.5803620978;84188.57905710432;91311;17981.370652027115;18836.717449238;18975.90512047486;19009.809901900804;19072.237110515423;19147.329843455413;19366.322178723676;19382.612347752685;20058.39824805258;20296.391108266776;18846.52883677919;19383;19799.40601781949;19836.900815495832;20068.899655502213;16145;16212;16714.33142674328;16895.07077110771;16902.323907044072;18431.72352414688;18929.90535047316;19202.8079719201;19323.51691207731;19462.12420441112;12102.394880255775;12178.939105304416;12485.31330776816;12688.365581721062;12828.230306181658;13002.739945201232;13271.469141234242;13271.601851944457;13640.65898352549;13756.862431375559 03:45:54 INFO - PID 32328 | __end_tp_report 03:45:54 INFO - PID 32328 | __start_cc_report 03:45:54 INFO - PID 32328 | _x_x_mozilla_cycle_collect,312 03:45:54 INFO - PID 32328 | __end_cc_report 03:45:54 INFO - PID 32328 | __startTimestamp1506854754694__endTimestamp 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | ------- Summary: start ------- 03:45:54 INFO - PID 32328 | Number of tests: 6 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#0] dojo.html Cycles:165 Average:6204.28 Median:6433.90 stddev:737.55 (11.5%) stddev-sans-first:700.27 03:45:54 INFO - PID 32328 | Values: 3166.8 3195.1 3214.2 3252.0 3253.7 6192.3 6200.4 6215.6 6326.4 6347.4 6240.7 6264.5 6267.4 6292.6 6343.6 5746.4 5797.9 5836.6 5839.8 5897.7 5619.4 5820.8 5926.4 5955.0 5976.9 5315.6 5677.8 5798.7 5823.8 5867.1 5776.0 5803.4 5855.7 5865.2 5893.0 5637.7 5706.5 5761.7 5835.2 5835.9 6296.7 6325.8 6331.9 6339.7 6359.2 6726.3 6742.2 6815.0 6844.0 6852.9 6688.6 6791.3 6810.3 6885.1 6896.7 6285.5 6295.6 6298.1 6304.4 6316.3 6889.2 6905.4 6916.4 6980.5 6999.6 6560.9 6596.5 6640.4 6653.2 6664.7 6738.2 6739.9 6810.4 6812.2 6818.7 6712.2 6720.6 6756.9 6777.5 6779.4 6645.8 6744.2 6751.2 6846.9 6852.1 5208.0 5232.0 5284.2 5351.6 5351.8 4611.7 4650.4 4672.0 4689.6 4709.2 5776.0 5867.8 5870.3 5891.6 5902.4 6563.5 6761.9 6764.6 6789.5 6820.7 5737.2 5740.2 5754.3 5756.0 5763.4 5803.2 5816.4 5827.3 5839.2 5850.8 6402.2 6500.2 6510.8 6554.0 6589.6 6711.3 6764.3 6782.4 6785.6 6786.2 6414.0 6424.2 6431.5 6508.9 6511.2 6480.7 6653.8 6733.6 6754.4 6756.7 6752.6 6757.5 6760.9 6768.8 6771.2 6497.1 6499.8 6503.4 6504.5 6506.8 6413.2 6485.1 6598.4 6598.5 6630.2 6475.1 6476.9 6544.5 6572.5 6572.8 6433.9 6591.9 6597.6 6700.9 6712.3 6345.6 6387.6 6441.2 6455.7 6476.0 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#1] ext.html Cycles:180 Average:37301.33 Median:34880.56 stddev:53642.39 (153.8%) stddev-sans-first:53723.07 03:45:54 INFO - PID 32328 | Values: 854.6 882.8 907.7 912.5 913.8 39712.6 42090.8 42125.8 42176.4 42271.4 37725.4 38026.6 38159.6 38227.4 38499.2 7273.0 7389.0 7398.4 7402.3 7412.4 7287.9 7359.0 7369.4 7376.9 7383.5 7350.1 7351.6 7947.6 8163.3 8184.4 8102.2 8169.8 8172.5 8174.1 8175.1 7544.8 7842.4 7967.4 8031.5 8062.5 37522.0 38188.2 38267.8 38361.6 38397.2 3510.0 3557.3 3579.0 3579.2 3579.7 31378.8 31630.0 31793.2 31982.8 31996.9 5123.3 5160.9 5163.1 5193.0 5220.7 197149.0 197206.0 197450.0 197633.0 198036.0 48415.3 48644.5 48723.8 48760.5 48930.8 51258.0 51349.2 51509.5 51520.1 51553.2 15620.5 15765.8 15791.2 15815.7 15897.2 12929.2 12975.3 13007.8 13033.3 13047.5 13441.9 13584.5 13589.6 13649.8 13738.8 5676.7 5751.7 5817.4 5836.7 5842.0 984.9 989.9 1002.4 1013.5 1015.4 22754.5 22810.4 22857.3 22866.8 22891.9 1092.2 1093.5 1102.7 1111.0 1111.3 12037.3 12108.5 12214.9 12245.9 12331.5 222629.0 222845.0 223367.5 223981.0 226072.0 53159.0 53549.2 55107.7 56070.7 56453.7 1403.5 1430.7 1434.9 1437.7 1438.0 26074.5 26090.5 26107.6 26331.7 26997.6 35932.8 36137.3 36217.6 36227.5 36257.5 197488.0 199069.0 199248.0 199305.0 199443.0 31928.7 32126.8 32219.4 32234.5 32252.2 38580.6 40258.4 40468.0 41157.4 41223.8 30203.5 30488.0 30658.8 30942.0 30966.8 29844.7 30100.8 30139.0 30379.4 30475.2 34237.7 34647.8 34770.7 34990.5 35055.3 29316.6 29720.9 29780.0 29882.7 30018.0 22315.9 22389.7 22707.0 22978.8 23322.8 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#2] jquery.html Cycles:180 Average:34708.83 Median:23199.84 stddev:80637.95 (347.6%) stddev-sans-first:80823.44 03:45:54 INFO - PID 32328 | Values: 577.2 586.9 590.1 593.0 599.5 22438.1 23276.4 23316.5 23335.6 23336.0 24169.6 24889.1 24949.8 25021.7 25027.2 6583.2 6637.3 6685.3 6686.3 6689.3 6277.7 6539.6 6590.6 6640.4 6640.8 6417.2 6521.9 6527.6 6529.4 6530.2 6386.6 6397.3 6522.2 6525.2 6535.7 5886.4 6088.1 6137.3 6137.6 6152.8 28343.7 28625.1 28703.6 28852.7 28906.6 1976.7 2005.1 2016.8 2017.9 2021.1 17919.2 18240.4 18445.8 18464.6 18507.3 2470.9 2473.8 2497.7 2502.0 2502.9 126394.4 132234.0 142570.0 150885.0 151041.0 14712.6 14911.8 15086.1 15212.0 15583.8 23971.8 24016.4 24047.4 24071.5 24119.9 10315.7 10407.1 10426.6 10480.4 10495.8 9547.9 9558.6 9598.2 9607.7 9654.4 9051.1 9131.9 9149.2 9301.3 9408.4 2692.8 2755.5 2785.4 2874.2 2895.4 943.4 961.8 966.4 973.1 974.8 18998.0 19062.6 19381.3 19542.9 19602.8 1030.9 1037.6 1049.5 1056.7 1063.9 10389.2 10475.5 10740.6 10767.9 10825.6 464969.0 465707.0 476769.0 481955.0 482664.0 124195.4 124219.0 127706.0 128691.0 128974.4 1050.0 1073.7 1165.4 1203.4 1204.3 20008.2 20327.7 20403.6 20505.3 20745.4 55904.7 56080.2 56614.4 56736.1 57541.7 70514.6 71805.0 72107.9 72463.0 72625.3 14242.8 14545.5 14604.3 14610.2 14635.2 21274.0 21695.3 22580.5 22903.8 23123.3 18135.2 18137.7 18169.3 18398.4 18586.2 15806.3 16466.9 16512.4 16708.2 17219.3 17865.4 18656.6 18731.6 18929.9 18938.3 14454.3 14461.3 14630.9 14636.9 14641.2 17296.9 17332.4 17436.5 17493.2 17493.6 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#3] mootools.html Cycles:180 Average:9168.82 Median:2715.12 stddev:6380.62 (235.0%) stddev-sans-first:6371.29 03:45:54 INFO - PID 32328 | Values: 1323.3 1411.8 1414.6 1417.0 1419.8 14508.5 15100.9 15102.5 15116.8 15117.2 14727.3 14898.9 14905.8 14944.3 14968.1 2698.1 2810.9 2814.4 2817.1 2818.9 2719.4 2780.3 2797.5 2799.1 2799.6 2696.2 2776.7 2799.4 2807.3 2807.5 2746.7 2795.1 2821.8 2825.3 2827.4 2710.9 2809.2 2825.8 2827.9 2828.7 14626.9 14655.9 14669.9 14770.6 14810.0 7528.2 7808.0 7840.5 7851.6 7871.3 4979.3 5190.4 5342.4 5429.2 5515.9 1942.9 1953.7 1998.2 2012.7 2025.6 24939.3 25206.6 25235.4 25241.7 25269.4 6556.4 6560.7 6613.9 6687.4 6755.2 16117.4 16247.6 16297.7 16815.6 17217.1 7527.0 7894.0 7895.2 7896.3 7896.6 7010.3 7030.3 7054.9 7246.3 7305.9 5083.2 5281.3 5283.7 5290.7 5297.8 1539.4 1544.6 1546.3 1556.5 1558.0 896.4 927.9 937.0 939.4 944.1 7658.3 7784.8 7806.4 7810.7 7858.4 716.8 718.4 731.5 733.6 738.7 4841.0 5235.0 5544.4 5601.7 5728.5 20588.8 20623.8 20892.5 21050.8 21448.9 19260.2 20616.5 21051.4 21066.5 21132.4 11103.2 11106.4 11115.8 11166.6 11216.8 8088.6 8390.9 8500.7 8544.2 8634.3 17509.2 17567.0 17904.3 17974.8 18185.0 18336.3 18405.5 18468.4 18528.4 18640.5 10931.5 11154.8 11173.2 11177.2 11183.9 13525.6 13593.3 13728.0 13749.5 13767.2 11223.6 11293.9 11301.9 11653.4 11681.8 11054.9 11227.1 11253.5 11413.7 11526.2 9904.9 9917.6 10045.9 10065.7 10070.1 7322.2 7454.3 7466.7 7496.9 7576.4 7677.5 7695.3 7701.3 7786.4 7859.3 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#4] prototype.html Cycles:180 Average:5592.23 Median:6282.31 stddev:1552.52 (24.7%) stddev-sans-first:1509.13 03:45:54 INFO - PID 32328 | Values: 501.8 502.4 533.3 534.0 541.0 6303.7 6314.5 6353.6 6418.0 6464.0 6281.6 6283.0 6284.2 6336.7 6374.2 5267.3 5294.0 5308.9 5316.1 5319.1 4916.1 5240.3 5264.2 5317.7 5360.2 4987.8 5023.4 5049.2 5060.2 5073.9 5063.3 5083.6 5090.2 5090.7 5104.3 4495.8 4571.6 4582.1 4595.0 4600.4 6012.2 6233.5 6234.3 6256.3 6257.1 5695.9 5819.0 5821.9 5834.8 5863.5 6688.7 6707.0 6728.0 6737.8 6761.7 4795.9 5001.8 5006.8 5022.7 5027.5 6555.6 6761.0 6785.6 6904.4 6938.6 5013.2 5017.6 5023.6 5065.0 5077.7 5059.7 5075.0 5134.9 5147.3 5190.8 5747.4 5801.7 5802.9 5804.4 5826.4 6488.0 6524.8 6615.4 6619.6 6690.8 1758.3 1796.5 1797.5 1800.6 1812.4 1210.1 1243.5 1247.9 1248.9 1265.2 5689.0 5694.2 5726.5 5750.9 5874.8 6685.9 6757.5 6816.5 6845.2 6872.9 5783.4 5876.0 5878.7 5912.5 5921.5 3593.9 3606.2 3617.3 3637.4 3655.7 6332.8 6528.5 6558.0 6609.1 6669.0 6962.7 6978.0 7017.1 7020.3 7038.9 6418.6 6438.9 6446.4 6597.8 6605.3 6728.7 6796.2 6800.8 6810.3 6826.3 6736.4 6740.3 6742.4 6767.9 6785.2 6484.0 6493.4 6495.4 6514.2 6568.6 5123.6 5124.1 5127.4 5127.5 5178.9 6466.9 6642.4 6789.4 6896.4 6911.6 6381.4 6557.9 6587.2 6640.4 6659.7 6524.2 6573.0 6606.5 6650.5 6659.3 6421.6 6441.7 6492.5 6552.3 6563.7 6547.6 6636.4 6687.9 6741.8 6756.5 6391.6 6454.2 6475.5 6512.8 6528.8 03:45:54 INFO - PID 32328 | 03:45:54 INFO - PID 32328 | [#5] yui.html Cycles:180 Average:25928.15 Median:19219.62 stddev:36879.68 (191.9%) stddev-sans-first:36935.25 03:45:54 INFO - PID 32328 | Values: 897.7 917.4 925.3 928.3 939.0 17077.4 17846.9 17907.4 18050.5 18075.1 18721.9 18885.2 18921.6 18925.7 18958.1 953.1 953.5 959.9 959.9 961.9 976.7 977.9 978.5 978.7 982.1 990.2 1026.2 1029.9 1031.5 1031.6 1010.7 1014.4 1016.0 1016.9 1022.0 718.0 736.5 739.8 746.7 753.7 18947.3 19166.7 19171.3 19183.9 19236.4 21543.8 21571.4 22252.9 22467.9 22494.8 15683.1 15772.0 15907.2 16083.3 16131.4 3734.6 3762.4 3766.9 3770.7 3773.3 105049.2 138395.0 144092.0 144141.0 145583.0 17964.9 18308.0 18393.4 18524.6 18524.8 32320.0 33166.5 33459.5 33469.5 33513.2 9320.3 9470.1 9728.3 9758.5 9791.8 4526.6 4570.8 4586.8 4600.3 4600.8 5408.8 5485.7 5509.3 5541.1 5577.0 1106.3 1112.3 1129.4 1132.2 1139.1 674.7 678.4 690.8 696.1 708.6 11858.9 11982.0 12138.3 12236.0 12452.9 693.1 697.1 697.2 704.9 717.6 5789.6 5939.5 5941.9 5954.4 6019.4 127494.7 127920.4 128656.4 129187.0 132452.0 107666.0 108758.0 110517.0 112699.0 115743.4 99135.5 99261.0 101333.0 102807.0 104238.5 11620.7 11652.5 12017.8 12064.4 12399.8 44233.0 45199.0 46016.3 46191.0 46859.3 80047.0 81726.6 83927.6 84188.6 91311.0 17981.4 18836.7 18975.9 19009.8 19072.2 19147.3 19366.3 19382.6 20058.4 20296.4 18846.5 19383.0 19799.4 19836.9 20068.9 16145.0 16212.0 16714.3 16895.1 16902.3 18431.7 18929.9 19202.8 19323.5 19462.1 12102.4 12178.9 12485.3 12688.4 12828.2 13002.7 13271.5 13271.6 13640.7 13756.9 03:45:54 INFO - PID 32328 | -------- Summary: end -------- 03:45:54 INFO - PID 32328 | 03:45:55 INFO - TEST-INFO | 32328: exit 0 03:45:55 INFO - TEST-OK | dromaeo_css | took 1108623ms 03:45:55 INFO - TEST-START | kraken 03:45:55 INFO - Initialising browser for kraken test... 03:45:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44020/getInfo.html -profile /tmp/tmpLbMEoU/profile 03:45:55 INFO - TEST-INFO | started process 32690 (/builds/slave/test/build/application/firefox/firefox http://localhost:44020/getInfo.html) 03:46:00 INFO - TEST-INFO | 32690: exit 0 03:46:00 INFO - Browser initialized. 03:46:00 INFO - Running cycle 1/1 for kraken test... 03:46:00 INFO - Using env: {'DISPLAY': ':0', 03:46:00 INFO - 'HOME': '/home/cltbld', 03:46:00 INFO - 'JSGC_DISABLE_POISONING': '1', 03:46:00 INFO - 'LANG': 'en_US.UTF-8', 03:46:00 INFO - 'LANGUAGE': 'en_US:en', 03:46:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:46:00 INFO - 'LOGNAME': 'cltbld', 03:46:00 INFO - 'MAIL': '/var/mail/cltbld', 03:46:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:00 INFO - 'MOZ_CRASHREPORTER': '1', 03:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:46:00 INFO - 'MOZ_NO_REMOTE': '1', 03:46:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:00 INFO - 'NO_EM_RESTART': '1', 03:46:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:00 INFO - 'PWD': '/builds/slave/test', 03:46:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:00 INFO - 'RUST_BACKTRACE': 'full', 03:46:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:46:00 INFO - 'SHELL': '/bin/bash', 03:46:00 INFO - 'SHLVL': '1', 03:46:00 INFO - 'STYLO_FORCE_DISABLED': '1', 03:46:00 INFO - 'TERM': 'linux', 03:46:00 INFO - 'TMOUT': '86400', 03:46:00 INFO - 'USER': 'cltbld', 03:46:00 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574', 03:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:00 INFO - '_': '/tools/buildbot/bin/python'} 03:46:00 INFO - TEST-INFO | started process 455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbMEoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:01 INFO - PID 455 | 03:46:01 INFO - PID 455 | (/builds/slave/test/build/application/firefox/firefox:505): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:46:01 INFO - PID 455 | 03:46:11 INFO - PID 455 | RSS: Main: 153907200 03:46:11 INFO - PID 455 | 03:46:14 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44020/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:15 INFO - PID 455 | RSS: Main: 161083392 03:46:15 INFO - PID 455 | 03:46:17 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44020/tests/kraken/driver.html?testName=audio-dft) 03:46:18 INFO - PID 455 | RSS: Main: 160710656 03:46:18 INFO - PID 455 | 03:46:21 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44020/tests/kraken/driver.html?testName=audio-fft) 03:46:21 INFO - PID 455 | RSS: Main: 156446720 03:46:21 INFO - PID 455 | 03:46:24 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44020/tests/kraken/driver.html?testName=audio-oscillator) 03:46:24 INFO - PID 455 | RSS: Main: 156766208 03:46:24 INFO - PID 455 | 03:46:26 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:27 INFO - PID 455 | RSS: Main: 157306880 03:46:27 INFO - PID 455 | 03:46:30 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44020/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:31 INFO - PID 455 | RSS: Main: 160124928 03:46:31 INFO - PID 455 | 03:46:34 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44020/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:35 INFO - PID 455 | RSS: Main: 160169984 03:46:35 INFO - PID 455 | 03:46:38 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44020/tests/kraken/driver.html?testName=json-parse-financial) 03:46:38 INFO - PID 455 | RSS: Main: 160243712 03:46:38 INFO - PID 455 | 03:46:40 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:41 INFO - PID 455 | RSS: Main: 160100352 03:46:41 INFO - PID 455 | 03:46:42 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:43 INFO - PID 455 | RSS: Main: 159961088 03:46:43 INFO - PID 455 | 03:46:45 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:46 INFO - PID 455 | RSS: Main: 156856320 03:46:46 INFO - PID 455 | 03:46:48 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:49 INFO - PID 455 | RSS: Main: 156803072 03:46:49 INFO - PID 455 | 03:46:52 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:52 INFO - PID 455 | RSS: Main: 157192192 03:46:52 INFO - PID 455 | 03:46:54 INFO - PID 455 | Cycle 1(1): loaded http://localhost:44020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44020/tests/kraken/driver.html?testName=ai-astar) 03:46:54 INFO - PID 455 | RSS: Main: 158539776 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | __start_tp_report 03:46:54 INFO - PID 455 | _x_x_mozilla_page_load 03:46:54 INFO - PID 455 | _x_x_mozilla_page_load_details 03:46:54 INFO - PID 455 | |i|pagename|runs| 03:46:54 INFO - PID 455 | |0;ai-astar;109;108;108;108;109;108;107;109;109;111 03:46:54 INFO - PID 455 | |1;audio-beat-detection;119;118;119;115;117;120;117;117;116;119 03:46:54 INFO - PID 455 | |2;audio-dft;163;162;164;163;162;162;162;168;166;164 03:46:54 INFO - PID 455 | |3;audio-fft;76;74;74;75;74;76;76;74;77;75 03:46:54 INFO - PID 455 | |4;audio-oscillator;80;80;79;79;81;81;80;78;78;80 03:46:54 INFO - PID 455 | |5;imaging-gaussian-blur;111;116;114;112;111;112;112;113;113;113 03:46:54 INFO - PID 455 | |6;imaging-darkroom;161;148;149;148;149;149;147;148;148;148 03:46:54 INFO - PID 455 | |7;imaging-desaturate;93;94;93;95;94;94;95;95;94;95 03:46:54 INFO - PID 455 | |8;json-parse-financial;54;50;50;52;51;52;51;52;52;51 03:46:54 INFO - PID 455 | |9;json-stringify-tinderbox;37;37;37;37;37;37;38;38;37;38 03:46:54 INFO - PID 455 | |10;stanford-crypto-aes;78;76;76;74;75;76;75;74;79;76 03:46:54 INFO - PID 455 | |11;stanford-crypto-ccm;112;114;112;115;118;116;115;118;109;112 03:46:54 INFO - PID 455 | |12;stanford-crypto-pbkdf2;165;168;163;165;165;163;171;166;163;170 03:46:54 INFO - PID 455 | |13;stanford-crypto-sha256-iterative;64;66;64;66;62;66;65;65;64;65 03:46:54 INFO - PID 455 | __end_tp_report 03:46:54 INFO - PID 455 | __start_cc_report 03:46:54 INFO - PID 455 | _x_x_mozilla_cycle_collect,715 03:46:54 INFO - PID 455 | __end_cc_report 03:46:54 INFO - PID 455 | __startTimestamp1506854814835__endTimestamp 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | ------- Summary: start ------- 03:46:54 INFO - PID 455 | Number of tests: 14 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.07 (1.0%) stddev-sans-first:1.13 03:46:54 INFO - PID 455 | Values: 109.0 108.0 108.0 108.0 109.0 108.0 107.0 109.0 109.0 111.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:118.50 stddev:1.57 (1.3%) stddev-sans-first:1.59 03:46:54 INFO - PID 455 | Values: 119.0 118.0 119.0 115.0 117.0 120.0 117.0 117.0 116.0 119.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.12 03:46:54 INFO - PID 455 | Values: 163.0 162.0 164.0 163.0 162.0 162.0 162.0 168.0 166.0 164.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.50 stddev:1.10 (1.5%) stddev-sans-first:1.12 03:46:54 INFO - PID 455 | Values: 76.0 74.0 74.0 75.0 74.0 76.0 76.0 74.0 77.0 75.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:80.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 03:46:54 INFO - PID 455 | Values: 80.0 80.0 79.0 79.0 81.0 81.0 80.0 78.0 78.0 80.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:1.49 (1.3%) stddev-sans-first:1.45 03:46:54 INFO - PID 455 | Values: 111.0 116.0 114.0 112.0 111.0 112.0 112.0 113.0 113.0 113.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:148.50 stddev:4.09 (2.8%) stddev-sans-first:0.67 03:46:54 INFO - PID 455 | Values: 161.0 148.0 149.0 148.0 149.0 149.0 147.0 148.0 148.0 148.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 03:46:54 INFO - PID 455 | Values: 93.0 94.0 93.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.18 (2.3%) stddev-sans-first:0.83 03:46:54 INFO - PID 455 | Values: 54.0 50.0 50.0 52.0 51.0 52.0 51.0 52.0 52.0 51.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 03:46:54 INFO - PID 455 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 38.0 38.0 37.0 38.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.60 (2.1%) stddev-sans-first:1.50 03:46:54 INFO - PID 455 | Values: 78.0 76.0 76.0 74.0 75.0 76.0 75.0 74.0 79.0 76.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:115.00 stddev:2.88 (2.5%) stddev-sans-first:2.96 03:46:54 INFO - PID 455 | Values: 112.0 114.0 112.0 115.0 118.0 116.0 115.0 118.0 109.0 112.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:2.88 (1.7%) stddev-sans-first:3.04 03:46:54 INFO - PID 455 | Values: 165.0 168.0 163.0 165.0 165.0 163.0 171.0 166.0 163.0 170.0 03:46:54 INFO - PID 455 | 03:46:54 INFO - PID 455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 03:46:54 INFO - PID 455 | Values: 64.0 66.0 64.0 66.0 62.0 66.0 65.0 65.0 64.0 65.0 03:46:54 INFO - PID 455 | -------- Summary: end -------- 03:46:54 INFO - PID 455 | 03:46:55 INFO - PID 455 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:46:55 INFO - TEST-INFO | 455: exit 0 03:46:55 INFO - TEST-OK | kraken | took 60305ms 03:46:55 INFO - SUITE-END | took 1168s 03:46:55 INFO - Completed test suite (00:19:29) 03:46:55 INFO - javascript benchmark 03:46:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8588.063372453713, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.809991400516, 3195.0734287056753, 3214.212517933107, 3252.0406480088373, 3253.6746325367453, 6192.349803270654, 6200.410960958713, 6215.62706237626, 6326.367363263671, 6347.396997285262, 6240.719167637456, 6264.467520260783, 6267.37326267373, 6292.590981586205, 6343.619382837033, 5746.425357464262, 5797.855053623651, 5836.5914385993, 5839.824805255849, 5897.705114744245, 5619.381867994538, 5820.796272130477, 5926.4073592640825, 5954.970225148868, 5976.8505787355225, 5315.627906046579, 5677.801276955287, 5798.681072541009, 5823.825285241471, 5867.090600956859, 5775.989201889694, 5803.419658034205, 5855.677937713424, 5865.208196893407, 5893.0, 5637.661740295595, 5706.4864162225185, 5761.711914404263, 5835.183074369592, 5835.883282334372, 6296.68516574174, 6325.810225693191, 6331.873362532723, 6339.683015849235, 6359.173307470046, 6726.293739157367, 6742.157230346207, 6815.045893574904, 6844.041834143224, 6852.862942741167, 6688.565243259172, 6791.320867913169, 6810.284920083419, 6885.1049363582915, 6896.724131034753, 6285.497160227171, 6295.5907865988565, 6298.055291706235, 6304.369563043705, 6316.2736285326855, 6889.173299204027, 6905.413039891666, 6916.446684265246, 6980.511364204457, 6999.580025198505, 6560.901586476207, 6596.505262105361, 6640.369164929421, 6653.168353955755, 6664.700088496029, 6738.225104113089, 6739.932600674028, 6810.421114205249, 6812.182538095461, 6818.659067046727, 6712.228093769181, 6720.630365329856, 6756.932430675631, 6777.457803375718, 6779.389854913082, 6645.833854153685, 6744.224414192333, 6751.223609284897, 6846.931530684729, 6852.074969879002, 5207.973960130251, 5232.03207406631, 5284.180951952453, 5351.625386222927, 5351.812686555952, 4611.677182597253, 4650.441946966318, 4672.0, 4689.554492323224, 4709.175894218498, 5776.0, 5867.794627188114, 5870.295564532284, 5891.587588868738, 5902.380250073767, 6563.474922006228, 6761.898571521431, 6764.5603035802515, 6789.490788190906, 6820.693068811816, 5737.196792448977, 5740.225069615632, 5754.251947246915, 5756.0, 5763.366029736726, 5803.245578074823, 5816.360200377955, 5827.3007239131575, 5839.182514447981, 5850.795222167204, 6402.231732192166, 6500.154979852589, 6510.837229069217, 6554.0, 6589.571677840925, 6711.295313992058, 6764.2559318475915, 6782.355676210752, 6785.558938668971, 6786.21958474762, 6413.967930160506, 6424.164858568356, 6431.549791514736, 6508.869822603427, 6511.153550038464, 6480.740770369321, 6653.767118150841, 6733.562318449285, 6754.3921047106, 6756.662166891734, 6752.628605426748, 6757.459403247827, 6760.898586521108, 6768.796936091925, 6771.187457505131, 6497.090407342881, 6499.837504062436, 6503.44720698727, 6504.512161587994, 6506.804795856132, 6413.198350206224, 6485.124508191334, 6598.406143447113, 6598.538102332791, 6630.204375474781, 6475.061116138228, 6476.902846457401, 6544.5418820684, 6572.539922205591, 6572.8356791080605, 6433.903491447539, 6591.901121483085, 6597.637129957899, 6700.899486507608, 6712.2616512184595, 6345.587536810092, 6387.552871298964, 6441.194850643669, 6455.741770329134, 6476.028595710681], "value": 6149.152047895023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.645322191291, 882.8322618702446, 907.7004588485801, 912.5346073502511, 913.7578541686454, 39712.602873971286, 42090.78954605226, 42125.78937105314, 42176.36735448971, 42271.365929511085, 37725.43411848824, 38026.619733802654, 38159.618403815955, 38227.42658860113, 38499.23001539968, 7273.0, 7388.963055184717, 7398.408127349826, 7402.29678180572, 7412.407007439392, 7287.8542429151385, 7359.043324367824, 7369.410447164214, 7376.889346659805, 7383.48315617907, 7350.11798584168, 7351.558906465602, 7947.642356093989, 8163.265306122448, 8184.386171037167, 8102.230288122619, 8169.754907352789, 8172.509649421054, 8174.100848906615, 8175.14161013097, 7544.8113797154965, 7842.372610191171, 7967.402444816604, 8031.518108913426, 8062.475939064001, 37522.0, 38188.23623527514, 38267.8086609568, 38361.616383836365, 38397.232055358734, 3509.982450087733, 3557.2707594942976, 3579.0336609115393, 3579.176789338441, 3579.731520136, 31378.843105784326, 31630.0, 31793.205169870707, 31982.840085799424, 31996.8801091963, 5123.2827404163445, 5160.870978225575, 5163.122269214243, 5193.0, 5220.712860792655, 197149.0, 197206.0, 197450.0, 197633.0, 198036.0, 48415.273770893466, 48644.51355486471, 48723.75638121787, 48760.51239487631, 48930.755346223756, 51258.0, 51349.22976155286, 51509.48490515122, 51520.13598980092, 51553.22670159875, 15620.453284135001, 15765.763513547307, 15791.21043947798, 15815.683686326209, 15897.205139742966, 12929.224246545238, 12975.286359250144, 13007.804882926765, 13033.283169425773, 13047.478100875858, 13441.865581344256, 13584.456621735217, 13589.592312230649, 13649.795253071212, 13738.793918091236, 5676.744546495418, 5751.712414379264, 5817.44734250254, 5836.737346819404, 5841.970790146022, 984.9064338887795, 989.9208063354914, 1002.3735165521549, 1013.4831236069657, 1015.3552494166257, 22754.544909101725, 22810.42973925665, 22857.31428057161, 22866.771332286466, 22891.885540572523, 1092.180864351736, 1093.475131936659, 1102.6747109602686, 1110.9611163609236, 1111.261011427408, 12037.277763334228, 12108.515659373526, 12214.938925305316, 12245.877541224652, 12331.50673973049, 222629.0, 222845.0, 223367.5326493461, 223981.0, 226072.0, 53159.0, 53549.1967620486, 55107.72446137744, 56070.71964640151, 56453.71773141108, 1403.5228022472204, 1430.6780974280703, 1434.938145772121, 1437.6549628089183, 1438.0365155345944, 26074.478510430064, 26090.478190435704, 26107.608385874606, 26331.736682632927, 26997.59503607487, 35932.820335898155, 36137.27725445424, 36217.63782362143, 36227.45658815173, 36257.45613815848, 197488.0, 199069.0, 199248.0, 199305.0, 199443.0, 31928.68071319257, 32126.83936580302, 32219.35561288808, 32234.516482253253, 32252.19369515781, 38580.614193858826, 40258.396124058745, 40468.0, 41157.382639259835, 41223.793881030404, 30203.546946795377, 30488.0, 30658.84670576633, 30942.0, 30966.845165774026, 29844.701552984192, 30100.84949575238, 30139.0, 30379.392412152076, 30475.2381190472, 34237.657623423445, 34647.82676086603, 34770.65229347775, 34990.47514287237, 35055.29889402249, 29316.56025159667, 29720.851395742884, 29780.0, 29882.701172987992, 30018.0, 22315.888420557792, 22389.66415503736, 22707.0, 22978.770212298332, 23322.76677233206], "value": 17002.93655654493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.232281066182, 586.9207656966308, 590.1148277583624, 592.9851753706154, 599.4994179859817, 22438.102475900963, 23276.41808954777, 23316.533669326604, 23335.649965250534, 23336.0, 24169.63745543814, 24889.12888048919, 24949.750502494968, 25021.74891255439, 25027.24918252451, 6583.177102862154, 6637.303083176269, 6685.264620891722, 6686.264510903797, 6689.264180940093, 6277.654728989904, 6539.64031978241, 6590.5716128451495, 6640.435562977153, 6640.800775976729, 6417.165768450095, 6521.869562608745, 6527.608343499382, 6529.412352888239, 6530.249021362532, 6386.552941294111, 6397.296297407282, 6522.15212022434, 6525.249596296439, 6535.673216339164, 5886.352501224862, 6088.086786981989, 6137.324894261627, 6137.60105593135, 6152.815415537541, 28343.716562834314, 28625.14124576266, 28703.56944645832, 28852.711472885214, 28906.566401503995, 1976.663967125592, 2005.0977060322914, 2016.8184863362221, 2017.8991050447567, 2021.1006102284489, 17919.1936362864, 18240.361587344378, 18445.815541844542, 18464.63070738578, 18507.2597096116, 2470.8641024743633, 2473.7773600376054, 2497.725250222474, 2501.962470562943, 2502.862342571158, 126394.36802815927, 132234.0, 142570.0, 150885.0, 151041.0, 14712.632184195267, 14911.812132134635, 15086.14015195032, 15212.011219270711, 15583.844161558465, 23971.760282397303, 24016.39959001039, 24047.398815029414, 24071.518569628508, 24119.879400602884, 10315.690529284133, 10407.115395191342, 10426.635067772591, 10480.371177729361, 10495.845456999725, 9547.899462118323, 9558.61765529371, 9598.232141428669, 9607.663731769495, 9654.372465789702, 9051.14014168653, 9131.908680913239, 9149.222316103072, 9301.302402319718, 9408.388454750419, 2692.7576518113074, 2755.4626847764494, 2785.359367345522, 2874.152125123094, 2895.406441679451, 943.4290860779649, 961.7547525381123, 966.3622009473854, 973.0707174648194, 974.8440249560036, 18998.0, 19062.61874762497, 19381.321653742052, 19542.902285488482, 19602.803971960384, 1030.8969701808378, 1037.6005237983431, 1049.522467277387, 1056.6882769582992, 1063.8936106389453, 10389.168866490663, 10475.528601212964, 10740.570377184982, 10767.946160269148, 10825.621103261348, 464969.0, 465707.0, 476769.0, 481955.0, 482664.0, 124195.37902310431, 124219.0, 127706.0, 128691.0, 128974.35512822376, 1049.9895001050045, 1073.672529878379, 1165.3823473559028, 1203.3983008495752, 1204.313541281461, 20008.199672012957, 20327.695084573446, 20403.59192816165, 20505.2823151189, 20745.377638670863, 55904.72047639736, 56080.15879761725, 56614.433855662566, 56736.14895776649, 57541.71229143828, 70514.64742676253, 71805.0, 72107.91838122538, 72463.0, 72625.27374726185, 14242.786358204843, 14545.490907818175, 14604.269786510844, 14610.196439195946, 14635.195064271567, 21274.0, 21695.34913952584, 22580.548389032458, 22903.770962290164, 23123.2657550681, 18135.183916723516, 18137.727934081264, 18169.273229070688, 18398.356057537923, 18586.163622636745, 15806.340334265196, 16466.917665411594, 16512.42206522766, 16708.164591770605, 17219.311227551258, 17865.374711885022, 18656.626867462302, 18731.625367492845, 18929.864208147555, 18938.337158199396, 14454.349554270293, 14461.276936152939, 14630.926845366132, 14636.85363146355, 14641.194734289717, 17296.91351543234, 17332.39336623212, 17436.47690569285, 17493.212805423533, 17493.562660933578], "value": 12003.4067001645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.3118778235319, 1411.7811739180424, 1414.6251243420502, 1417.0222546442953, 1419.801227828104, 14508.492202772904, 15100.924495377521, 15102.546923592283, 15116.848831511696, 15117.244137793094, 14727.337269822858, 14898.925505372457, 14905.776413353782, 14944.327505262263, 14968.101913885175, 2698.0961377938365, 2810.943781124376, 2814.408974115438, 2817.09852847089, 2818.929526761837, 2719.3881376690283, 2780.2771279467283, 2797.482465743834, 2799.0902956539103, 2799.5800629905575, 2696.1776658119265, 2776.694563598003, 2799.4401119776126, 2807.3402750353653, 2807.4946509628257, 2746.725327467257, 2795.11953734574, 2821.7883658725677, 2825.3219227385384, 2827.406244688618, 2710.850903200323, 2809.1993781772303, 2825.773938084969, 2827.9010234641896, 2828.7312705292966, 14626.853731462656, 14655.926720366437, 14669.853301466956, 14770.630734231623, 14810.0, 7528.247175282483, 7807.96096019522, 7840.4511684182135, 7851.646675899598, 7871.330936870373, 4979.278004689336, 5190.377154741417, 5342.385625653061, 5429.212764149176, 5515.862103447446, 1942.9417117486498, 1953.716711076886, 1998.2406685459578, 2012.7081573171808, 2025.6151331247015, 24939.251822445356, 25206.621900671504, 25235.369115772068, 25241.747582524124, 25269.368265793317, 6556.409923106848, 6560.737570497222, 6613.900791488131, 6687.398134167851, 6755.2231493378895, 16117.435889743803, 16247.59381015484, 16297.674046519003, 16815.57961050959, 17217.139143042798, 7527.0, 7893.960530197312, 7895.171007044178, 7896.289333959856, 7896.565688887166, 7010.334018268256, 7030.261822508665, 7054.92945070553, 7246.275372462712, 7305.853882922418, 5083.212102124176, 5281.260623512711, 5283.682979021194, 5290.68255904647, 5297.761600727977, 1539.4304107480305, 1544.5675210940954, 1546.304163126575, 1556.4630202580092, 1557.9922100389426, 896.3725392225468, 927.9118483744033, 936.9812603748023, 939.3847030195233, 944.1408318430196, 7658.2724641159, 7784.805379865548, 7806.375489960789, 7810.6875724971505, 7858.449908506464, 716.8458781362032, 718.4252597921642, 731.5098883747902, 733.5635296998278, 738.6639079218943, 4840.959193773285, 5235.0, 5544.417836127229, 5601.719914004283, 5728.51307638847, 20588.794112058986, 20623.793762062487, 20892.47768805792, 21050.78949210519, 21448.892755536122, 19260.229590816492, 20616.484587885123, 21051.368458946257, 21066.47333816667, 21132.366029019155, 11103.222774405876, 11106.389148596905, 11115.83326250107, 11166.609168679057, 11216.766155722864, 8088.636011379384, 8390.874136888073, 8500.70247541333, 8544.2310192083, 8634.266087382643, 17509.21208545593, 17567.0, 17904.28382864723, 17974.820251797315, 18185.0, 18336.266549337877, 18405.53986150357, 18468.353607623667, 18528.44414667562, 18640.533986649898, 10931.45342732876, 11154.776904462027, 11173.162012848907, 11177.161712871404, 11183.888161118284, 13525.64743525679, 13593.252371119683, 13728.0, 13749.518766843112, 13767.242801646005, 11223.60717374888, 11293.887061129284, 11301.886981130083, 11653.417329133339, 11681.824772628248, 11054.944725276322, 11227.101831853268, 11253.549858005588, 11413.657590272305, 11526.1931664786, 9904.851427228741, 9917.603295868084, 10045.949770251102, 10065.69802905914, 10070.144037756872, 7322.1579518356075, 7454.254574542502, 7466.701331946661, 7496.887546686695, 7576.431767617561, 7677.462577619513, 7695.307422332017, 7701.345385642283, 7786.4160187985, 7859.292663660298], "value": 6613.276179671744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.829378011476, 502.3594916481483, 533.346650353317, 533.9919901201481, 540.9837704868855, 6303.653299068549, 6314.526410519206, 6353.555251132422, 6418.0, 6463.967680161604, 6281.591696539722, 6283.026130949699, 6284.177588499341, 6336.651484168369, 6374.203224596926, 5267.341582302212, 5294.0, 5308.885134121839, 5316.149416093426, 5319.148936170213, 4916.115099282128, 5240.266362709223, 5264.157734762439, 5317.707526086064, 5360.249565060894, 4987.800487980477, 5023.447420783729, 5049.2173713074535, 5060.215666571669, 5073.873153171182, 5063.265826455144, 5083.551187911427, 5090.1855703087695, 5090.694558326494, 5104.285400043978, 4495.842645507424, 4571.6114130298965, 4582.1064892346, 4595.0, 4600.4479462464715, 6012.158297838306, 6233.532485063638, 6234.3453937336835, 6256.311805701369, 6257.124002639589, 5695.886082278331, 5818.970905145489, 5821.912671309934, 5834.795782147605, 5863.459031215503, 6688.699008544627, 6707.0, 6727.96322206677, 6737.831554211135, 6761.701021652612, 4795.889808484256, 5001.774920128603, 5006.799728010875, 5022.748862556858, 5027.49725027498, 6555.573887697285, 6761.039298603399, 6785.558938668971, 6904.447644188453, 6938.5836849789175, 5013.222950442687, 5017.623678224148, 5023.572996295356, 5064.974675126675, 5077.720725360066, 5059.747012649353, 5075.0, 5134.948650513522, 5147.3051138096625, 5190.8183213587345, 5747.3677895431465, 5801.7389217485315, 5802.883942321215, 5804.448577385142, 5826.388229235954, 6487.967560162263, 6524.804255872332, 6615.37153970372, 6619.569727967667, 6690.765823196165, 1758.261530157337, 1796.4790210838971, 1797.4877160009335, 1800.5588630785542, 1812.392848395776, 1210.1452468020675, 1243.5398902406168, 1247.9188852724726, 1248.8635341838883, 1265.2282107914166, 5688.999999999917, 5694.174344719992, 5726.541876649858, 5750.913736293959, 5874.823755287348, 6685.866282674319, 6757.493188010919, 6816.488763342769, 6845.178578570603, 6872.896906546406, 5783.363829978699, 5876.0, 5878.676672783038, 5912.497437717842, 5921.496672782861, 3593.9281214376088, 3606.1705807664384, 3617.3488772020764, 3637.3634613942454, 3655.670989610948, 6332.778352757631, 6528.51036172289, 6557.967210163919, 6609.140811694545, 6669.032990216391, 6962.686679099453, 6977.965110174417, 7017.052697885822, 7020.333068358498, 7038.92961070393, 6418.645540914367, 6438.937575300117, 6446.355364463516, 6597.835054123685, 6605.273419923805, 6728.73085076611, 6796.150481189851, 6800.82997925036, 6810.250872404131, 6826.293426643339, 6736.360045795642, 6740.325967403221, 6742.359475849787, 6767.864642707217, 6785.219699734594, 6483.967580162069, 6493.350664933658, 6495.415412612888, 6514.185726784152, 6568.573042752206, 5123.5644970177955, 5124.12889808726, 5127.3847138343635, 5127.4872512748425, 5178.8964220716125, 6466.902996454963, 6642.368974947372, 6789.422899053438, 6896.379325860697, 6911.619860907698, 6381.361863813581, 6557.885159522797, 6587.209534855848, 6640.369164929324, 6659.667016649245, 6524.249711283263, 6573.0, 6606.53754237218, 6650.534462587572, 6659.334066593496, 6421.64680942534, 6441.743859947265, 6492.48060155177, 6552.3447655236005, 6563.671816409065, 6547.639879806466, 6636.369544893228, 6687.929931210982, 6741.764038258638, 6756.493263005196, 6391.552591318563, 6454.225492940877, 6475.5318830007145, 6512.837179070371, 6528.804135875931], "value": 5135.478722029111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.6947837735169, 917.3761841947476, 925.2551695884814, 928.3316012471018, 939.0327962198935, 17077.37764912333, 17846.910765446188, 17907.373241936533, 18050.5487362816, 18075.09624518774, 18721.90639046803, 18885.150168242428, 18921.62156756864, 18925.716114258295, 18958.146883390247, 953.1136043479561, 953.532768943218, 959.8704174936399, 959.8848138223389, 961.8941916389192, 976.7069879036296, 977.8777652793401, 978.5107446276861, 978.7161723100328, 982.0572250639394, 990.2424645146468, 1026.2046913641911, 1029.907308342249, 1031.5358088860005, 1031.6286136990677, 1010.6967909627083, 1014.4420568687193, 1016.0398423489805, 1016.8881423043459, 1022.0137567247605, 717.9533330333512, 736.517580984456, 739.7669734033763, 746.7199800074972, 753.7135888362387, 18947.33684321042, 19166.712499312383, 19171.32900348481, 19183.90408047965, 19236.422907312663, 21543.784562154335, 21571.352859414244, 22252.888735556382, 22467.887660561755, 22494.77505224943, 15683.137427441487, 15772.0, 15907.20463976808, 16083.276252568663, 16131.435399761069, 3734.589195188527, 3762.435634654796, 3766.8681596144, 3770.679492243135, 3773.339665558544, 105049.2260910751, 138395.0, 144092.0, 144141.0, 145583.0, 17964.91017544904, 18308.0, 18393.448196554124, 18524.629507409776, 18524.814751852307, 32320.0, 33166.502502462485, 33459.49810752841, 33469.49795753066, 33513.162170945434, 9320.347575669639, 9470.14768670823, 9728.270379721549, 9758.46328451942, 9791.755206119904, 4526.569975852354, 4570.840020599263, 4586.770661466913, 4600.332951721982, 4600.7929643166135, 5408.756605952742, 5485.710857948379, 5509.256250406224, 5541.141123125922, 5576.972115139399, 1106.336198281041, 1112.2547892911768, 1129.412705393191, 1132.1565433751907, 1139.0602752729033, 674.7098747538605, 678.375894177358, 690.8031211104811, 696.1089805049545, 708.5606923707231, 11858.881411185777, 11982.0, 12138.27170369763, 12235.95994340491, 12452.937735311447, 693.0712844788009, 697.1425147069133, 697.2042111134388, 704.8977898204731, 717.587387252332, 5789.594728369058, 5939.524838013035, 5941.910871336933, 5954.4045595440975, 6019.428154325332, 127494.72505275015, 127920.36039819928, 128656.35671821768, 129187.0, 132452.0, 107666.0, 108758.0, 110517.0, 112699.0, 115743.42128289305, 99135.50432247936, 99261.0, 101333.0, 102807.0, 104238.478807607, 11620.6513804586, 11652.53389864396, 12017.759644807229, 12064.396780160781, 12399.814002789784, 44233.0, 45199.0, 46016.309755353024, 46191.0, 46859.297110542684, 80047.0, 81726.59136704278, 83927.5803620978, 84188.57905710432, 91311.0, 17981.370652027115, 18836.717449238, 18975.90512047486, 19009.809901900804, 19072.237110515423, 19147.329843455413, 19366.322178723676, 19382.612347752685, 20058.39824805258, 20296.391108266776, 18846.52883677919, 19383.0, 19799.40601781949, 19836.900815495832, 20068.899655502213, 16145.0, 16212.0, 16714.33142674328, 16895.07077110771, 16902.323907044072, 18431.72352414688, 18929.90535047316, 19202.8079719201, 19323.51691207731, 19462.12420441112, 12102.394880255775, 12178.939105304416, 12485.31330776816, 12688.365581721062, 12828.230306181658, 13002.739945201232, 13271.469141234242, 13271.601851944457, 13640.65898352549, 13756.862431375559], "value": 9412.497139285006, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1410.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 108.0, 108.0, 109.0, 108.0, 107.0, 109.0, 109.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 115.0, 117.0, 120.0, 117.0, 117.0, 116.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 162.0, 162.0, 162.0, 168.0, 166.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 75.0, 74.0, 76.0, 76.0, 74.0, 77.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 81.0, 81.0, 80.0, 78.0, 78.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 114.0, 112.0, 111.0, 112.0, 112.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 148.0, 149.0, 148.0, 149.0, 149.0, 147.0, 148.0, 148.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 50.0, 52.0, 51.0, 52.0, 51.0, 52.0, 52.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 38.0, 38.0, 37.0, 38.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 74.0, 75.0, 76.0, 75.0, 74.0, 79.0, 76.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 112.0, 115.0, 118.0, 116.0, 115.0, 118.0, 109.0, 112.0], "value": 114.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 163.0, 165.0, 165.0, 163.0, 171.0, 166.0, 163.0, 170.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 66.0, 62.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}]}]} 03:46:56 INFO - Return code: 0 03:46:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:56 INFO - # TBPL SUCCESS # 03:46:56 INFO - Running post-action listener: _package_coverage_data 03:46:56 INFO - Running post-action listener: _resource_record_post_action 03:46:56 INFO - [mozharness: 2017-10-01 10:46:56.130721Z] Finished run-tests step (success) 03:46:56 INFO - Running post-run listener: _resource_record_post_run 03:46:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 334983168; Read time: 0; Write time: 191988 03:46:56 INFO - TinderboxPrint: CPU usage
13.1% 03:46:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:46:56 INFO - TinderboxPrint: I/O write bytes / time
334,983,168 / 191,988 03:46:56 INFO - TinderboxPrint: CPU idle
8,222.4 (86.9%) 03:46:56 INFO - TinderboxPrint: CPU user
1,192.3 (12.6%) 03:46:56 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 3158016; Read time: 0; Write time: 176 03:46:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:46:56 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 331309056; Read time: 0; Write time: 191812 03:46:56 INFO - Running post-run listener: _upload_blobber_files 03:46:56 INFO - Blob upload gear active. 03:46:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:58 INFO - (blobuploader) - INFO - Done attempting. 03:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:59 INFO - (blobuploader) - INFO - Done attempting. 03:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:00 INFO - (blobuploader) - INFO - Done attempting. 03:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:07 INFO - (blobuploader) - INFO - Done attempting. 03:47:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:07 INFO - Return code: 0 03:47:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773973d01a329bca6d6b409197e4a06f149381dc8e3c82bddab1111daa29f80e60242a475882ab168bc0c2e4c6aa587661c4489cda41669b40edb760ce4e6c54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9af1c9505e98dfa4d09d7e95abda58c6c66d4096cff795374ede4356d0f30791a2ad3c2c1a9da1a7c599574bd72857e586de1d5dfdbfe8238cfc11a3436aa2c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/754a4bfac41d15a63d405313efd905e5dcb3f2362e21cb73a3554806e090a408ddd2eca779c46cc41cb94755e1f9650158fbd5273437d45021846ab195868fd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02cb029885774d27a500c40549b8e261994b90d4169cc8b503d0904759d162592de81e9c3752ef9058babea85b67a35aef90beca9a76463530eb6a3d2868e76e"} 03:47:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:07 INFO - Contents: 03:47:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773973d01a329bca6d6b409197e4a06f149381dc8e3c82bddab1111daa29f80e60242a475882ab168bc0c2e4c6aa587661c4489cda41669b40edb760ce4e6c54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9af1c9505e98dfa4d09d7e95abda58c6c66d4096cff795374ede4356d0f30791a2ad3c2c1a9da1a7c599574bd72857e586de1d5dfdbfe8238cfc11a3436aa2c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/754a4bfac41d15a63d405313efd905e5dcb3f2362e21cb73a3554806e090a408ddd2eca779c46cc41cb94755e1f9650158fbd5273437d45021846ab195868fd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02cb029885774d27a500c40549b8e261994b90d4169cc8b503d0904759d162592de81e9c3752ef9058babea85b67a35aef90beca9a76463530eb6a3d2868e76e"} 03:47:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:07 INFO - Copying logs to upload dir... 03:47:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.164307 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-10-01 03:47:07.601565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 03:47:07.609323) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 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/773973d01a329bca6d6b409197e4a06f149381dc8e3c82bddab1111daa29f80e60242a475882ab168bc0c2e4c6aa587661c4489cda41669b40edb760ce4e6c54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9af1c9505e98dfa4d09d7e95abda58c6c66d4096cff795374ede4356d0f30791a2ad3c2c1a9da1a7c599574bd72857e586de1d5dfdbfe8238cfc11a3436aa2c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/754a4bfac41d15a63d405313efd905e5dcb3f2362e21cb73a3554806e090a408ddd2eca779c46cc41cb94755e1f9650158fbd5273437d45021846ab195868fd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02cb029885774d27a500c40549b8e261994b90d4169cc8b503d0904759d162592de81e9c3752ef9058babea85b67a35aef90beca9a76463530eb6a3d2868e76e"} build_url:https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/KE1SBkzQRFq9ogOXBQsfvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/773973d01a329bca6d6b409197e4a06f149381dc8e3c82bddab1111daa29f80e60242a475882ab168bc0c2e4c6aa587661c4489cda41669b40edb760ce4e6c54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9af1c9505e98dfa4d09d7e95abda58c6c66d4096cff795374ede4356d0f30791a2ad3c2c1a9da1a7c599574bd72857e586de1d5dfdbfe8238cfc11a3436aa2c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/754a4bfac41d15a63d405313efd905e5dcb3f2362e21cb73a3554806e090a408ddd2eca779c46cc41cb94755e1f9650158fbd5273437d45021846ab195868fd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02cb029885774d27a500c40549b8e261994b90d4169cc8b503d0904759d162592de81e9c3752ef9058babea85b67a35aef90beca9a76463530eb6a3d2868e76e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 03:47:07.640447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:47:07.640776) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506853533.636072-203250574 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:47:07.727870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 03:47:07.728238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 03:47:07.728562) ========= ========= Total master_lag: 0.22 =========