builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-016 starttime: 1506104791.88 results: success (0) revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:31.880927) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:31.881482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:31.881849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:31.977091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:31.977546) ========= 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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 11:26:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 202M=0s 2017-09-22 11:26:32 (202 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118077 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:32.126174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:32.126520) ========= 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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018513 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:32.176147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 11:26:32.176456) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 11:26:32,233 truncating revision to first 12 chars 2017-09-22 11:26:32,233 Setting DEBUG logging. 2017-09-22 11:26:32,233 attempt 1/10 2017-09-22 11:26:32,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14db7c0bcf9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 11:26:33,193 unpacking tar archive at: mozilla-central-14db7c0bcf9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 11:26:33.427083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:33.427397) ========= script_repo_revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:33.427792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:33.428063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:26:33.441669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-22 11:26:33.441986) ========= /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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:33 INFO - MultiFileLogger online at 20170922 11:26:33 in /builds/slave/test 11:26:33 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 11:26:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:33 INFO - {'append_to_log': False, 11:26:33 INFO - 'base_work_dir': '/builds/slave/test', 11:26:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:26:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:33 INFO - 'branch': 'Firefox-Non-PGO', 11:26:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:33 INFO - 'code_coverage': False, 11:26:33 INFO - 'config_files': ('talos/linux_config.py',), 11:26:33 INFO - 'default_actions': ('clobber', 11:26:33 INFO - 'read-buildbot-config', 11:26:33 INFO - 'download-and-extract', 11:26:33 INFO - 'populate-webroot', 11:26:33 INFO - 'create-virtualenv', 11:26:33 INFO - 'install', 11:26:33 INFO - 'setup-mitmproxy', 11:26:33 INFO - 'run-tests'), 11:26:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:33 INFO - 'disable_ccov_upload': False, 11:26:33 INFO - 'disable_stylo': False, 11:26:33 INFO - 'download_minidump_stackwalk': True, 11:26:33 INFO - 'download_symbols': 'ondemand', 11:26:33 INFO - 'enable_stylo': False, 11:26:33 INFO - 'enable_webrender': False, 11:26:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:26:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:33 INFO - 'gecko_profile': False, 11:26:33 INFO - 'gecko_profile_interval': 0, 11:26:33 INFO - 'installer_path': 'installer.exe', 11:26:33 INFO - 'log_level': 'info', 11:26:33 INFO - 'log_name': 'talos', 11:26:33 INFO - 'log_to_console': True, 11:26:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:33 INFO - 'opt_config_files': (), 11:26:33 INFO - 'pip_index': False, 11:26:33 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:26:33 INFO - 'system_bits': '32', 11:26:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:33 INFO - 'title': 'talos-linux64-ix-016', 11:26:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:33 INFO - 'use_talos_json': True, 11:26:33 INFO - 'verify': 'False', 11:26:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:33 INFO - 'work_dir': 'build'} 11:26:33 INFO - [mozharness: 2017-09-22 18:26:33.709650Z] Running clobber step. 11:26:33 INFO - Running pre-action listener: _resource_record_pre_action 11:26:33 INFO - Running main action method: clobber 11:26:33 INFO - rmtree: /builds/slave/test/build 11:26:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:34 INFO - Running post-action listener: _resource_record_post_action 11:26:34 INFO - [mozharness: 2017-09-22 18:26:34.652952Z] Finished clobber step (success) 11:26:34 INFO - [mozharness: 2017-09-22 18:26:34.653050Z] Running read-buildbot-config step. 11:26:34 INFO - Running pre-action listener: _resource_record_pre_action 11:26:34 INFO - Running main action method: read_buildbot_config 11:26:34 INFO - Using buildbot properties: 11:26:34 INFO - { 11:26:34 INFO - "project": "", 11:26:34 INFO - "product": "firefox", 11:26:34 INFO - "who": "ffxbld@noreply.mozilla.org", 11:26:34 INFO - "installer_path": "public/build/target.tar.bz2", 11:26:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:26:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:26:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:26:34 INFO - "stage_platform": "linux64", 11:26:34 INFO - "basedir": "/builds/slave/test", 11:26:34 INFO - "buildnumber": 34, 11:26:34 INFO - "platform": "ubuntu64_hw", 11:26:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:26:34 INFO - "slavebuilddir": "test", 11:26:34 INFO - "taskId": "AQ7nNcVaQ1mfP0HaWovpqg", 11:26:34 INFO - "branch": "mozilla-central", 11:26:34 INFO - "script_repo_revision": "production", 11:26:34 INFO - "revision": "14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9", 11:26:34 INFO - "slavename": "talos-linux64-ix-016", 11:26:34 INFO - "repo_path": "mozilla-central" 11:26:34 INFO - } 11:26:34 INFO - Finding installer, test and symbols from parent task. 11:26:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQ7nNcVaQ1mfP0HaWovpqg'}, attempt #1 11:26:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQ7nNcVaQ1mfP0HaWovpqg'}, attempt #1 11:26:35 INFO - Task dependencies: O2QMI2-cQHqjA_lN8nP03w 11:26:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w'}, attempt #1 11:26:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 11:26:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.test_packages.json 11:26:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.crashreporter-symbols.zip 11:26:36 INFO - Running post-action listener: _resource_record_post_action 11:26:36 INFO - [mozharness: 2017-09-22 18:26:36.001350Z] Finished read-buildbot-config step (success) 11:26:36 INFO - [mozharness: 2017-09-22 18:26:36.001568Z] Running download-and-extract step. 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: download_and_extract 11:26:36 INFO - mkdir: /builds/slave/test/build/tests 11:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:36 INFO - trying https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.test_packages.json 11:26:36 INFO - Downloading https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:26:36 INFO - Downloaded 989 bytes. 11:26:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:26:36 INFO - Using the following test package requirements: 11:26:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:26:36 INFO - u'common': [u'target.common.tests.zip'], 11:26:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:26:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:26:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:26:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:26:36 INFO - u'mozbase': [u'target.common.tests.zip'], 11:26:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:26:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:26:36 INFO - u'web-platform': [u'target.common.tests.zip', 11:26:36 INFO - u'target.web-platform.tests.tar.gz'], 11:26:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:26:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:26:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.common.tests.zip 11:26:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:36 INFO - Fetch https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.common.tests.zip into memory 11:26:37 INFO - Content-Length response header: 54737734 11:26:37 INFO - Bytes received: 54737734 11:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.talos.tests.zip 11:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.talos.tests.zip into memory 11:26:49 INFO - Content-Length response header: 14513414 11:26:49 INFO - Bytes received: 14513414 11: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')]} 11:26:49 INFO - trying https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 11:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:26:50 INFO - Downloaded 61565956 bytes. 11:26:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 11:26:50 INFO - mkdir: /builds/slave/test/properties 11:26:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:50 INFO - Contents: 11:26:50 INFO - build_url:https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 11:26:50 INFO - Running post-action listener: _resource_record_post_action 11:26:50 INFO - Running post-action listener: find_tests_for_verification 11:26:50 INFO - Running post-action listener: set_extra_try_arguments 11:26:50 INFO - [mozharness: 2017-09-22 18:26:50.786211Z] Finished download-and-extract step (success) 11:26:50 INFO - [mozharness: 2017-09-22 18:26:50.786346Z] Running populate-webroot step. 11:26:50 INFO - Running pre-action listener: _resource_record_pre_action 11:26:50 INFO - Running main action method: populate_webroot 11:26:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['tresize', 11:26:50 INFO - 'tcanvasmark']}, 11:26:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['dromaeo_css', 11:26:50 INFO - 'kraken']}, 11:26:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'tests': ['damp', 'tps']}, 11:26:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['damp', 'tps']}, 11:26:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['dromaeo_dom']}, 11:26:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:26:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['basic_compositor_video', 11:26:50 INFO - 'glvideo']}, 11:26:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:26:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['ts_paint_webext', 11:26:50 INFO - 'tp5o_webext']}, 11:26:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:50 INFO - 'ts_paint', 11:26:50 INFO - 'tpaint', 11:26:50 INFO - 'sessionrestore', 11:26:50 INFO - 'sessionrestore_many_windows', 11:26:50 INFO - 'sessionrestore_no_auto_restore', 11:26:50 INFO - 'tabpaint']}, 11:26:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['a11yr', 11:26:50 INFO - 'ts_paint', 11:26:50 INFO - 'tpaint', 11:26:50 INFO - 'sessionrestore', 11:26:50 INFO - 'sessionrestore_many_windows', 11:26:50 INFO - 'sessionrestore_no_auto_restore', 11:26:50 INFO - 'tabpaint']}, 11:26:50 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:26:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:26:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['perf_reftest_singletons']}, 11:26:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['perf_reftest']}, 11:26:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:50 INFO - 'tsvgr_opacity', 11:26:50 INFO - 'tart', 11:26:50 INFO - 'tscrollx', 11:26:50 INFO - 'tsvg_static']}, 11:26:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['tsvgx', 11:26:50 INFO - 'tsvgr_opacity', 11:26:50 INFO - 'tart', 11:26:50 INFO - 'tscrollx', 11:26:50 INFO - 'tsvg_static']}, 11:26:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo'], 11:26:50 INFO - 'tests': ['tp5o']}, 11:26:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:50 INFO - 'talos_options': ['--mitmproxy', 11:26:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:50 INFO - '--firstNonBlankPaint'], 11:26:50 INFO - 'tests': ['tp6_google', 11:26:50 INFO - 'tp6_youtube', 11:26:50 INFO - 'tp6_amazon', 11:26:50 INFO - 'tp6_facebook']}, 11:26:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo', 11:26:50 INFO - '--mitmproxy', 11:26:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:50 INFO - '--firstNonBlankPaint'], 11:26:50 INFO - 'tests': ['tp6_google', 11:26:50 INFO - 'tp6_youtube', 11:26:50 INFO - 'tp6_amazon', 11:26:50 INFO - 'tp6_facebook']}, 11:26:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:50 INFO - 'talos_options': ['--stylo-threads=1', 11:26:50 INFO - '--mitmproxy', 11:26:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:50 INFO - '--firstNonBlankPaint'], 11:26:50 INFO - 'tests': ['tp6_google', 11:26:50 INFO - 'tp6_youtube', 11:26:50 INFO - 'tp6_amazon', 11:26:50 INFO - 'tp6_facebook']}, 11:26:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--xperf_path', 11:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:50 INFO - 'tests': ['tp5n']}, 11:26:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:50 INFO - 'talos_options': ['--disable-stylo', 11:26:50 INFO - '--xperf_path', 11:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:50 INFO - 'tests': ['tp5n']}}} 11:26:50 INFO - Running post-action listener: _resource_record_post_action 11:26:50 INFO - [mozharness: 2017-09-22 18:26:50.802699Z] Finished populate-webroot step (success) 11:26:50 INFO - [mozharness: 2017-09-22 18:26:50.802789Z] Running create-virtualenv step. 11:26:50 INFO - Running pre-action listener: _resource_record_pre_action 11:26:50 INFO - Running main action method: create_virtualenv 11:26:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:26:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:26:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:26:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:51 INFO - Installing pip...............done. 11:26:51 INFO - Return code: 0 11:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:26:52 INFO - Reading from file tmpfile_stdout 11:26:52 INFO - Output received: 11:26:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:26:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11: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')]} 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11: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', 'pip>=1.5'] in /builds/slave/test/build 11: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 pip>=1.5 11:26:52 INFO - Using env: {'DISPLAY': ':0', 11:26:52 INFO - 'HOME': '/home/cltbld', 11:26:52 INFO - 'LANG': 'en_US.UTF-8', 11:26:52 INFO - 'LANGUAGE': 'en_US:en', 11:26:52 INFO - 'LOGNAME': 'cltbld', 11:26:52 INFO - 'MAIL': '/var/mail/cltbld', 11:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:52 INFO - 'MOZ_NO_REMOTE': '1', 11:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:52 INFO - 'NO_EM_RESTART': '1', 11:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:52 INFO - 'PWD': '/builds/slave/test', 11:26:52 INFO - 'SHELL': '/bin/bash', 11:26:52 INFO - 'SHLVL': '1', 11:26:52 INFO - 'TERM': 'linux', 11:26:52 INFO - 'TMOUT': '86400', 11:26:52 INFO - 'USER': 'cltbld', 11:26:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:52 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:26:54 INFO - Downloading/unpacking pip>=1.5 11:26:54 INFO - Running setup.py egg_info for package pip 11:26:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:26:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:26:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:26:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:26:54 INFO - Installing collected packages: pip 11:26:54 INFO - Found existing installation: pip 1.1 11:26:54 INFO - Uninstalling pip: 11:26:54 INFO - Successfully uninstalled pip 11:26:54 INFO - Running setup.py install for pip 11:26:54 INFO - warning: no files found matching 'pip/cacert.pem' 11:26:54 INFO - warning: no files found matching '*.html' under directory 'docs' 11:26:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:26:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:26:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:26:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:26:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:26:54 INFO - Successfully installed pip 11:26:54 INFO - Cleaning up... 11:26:54 INFO - Return code: 0 11:26:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:26:54 INFO - Using env: {'DISPLAY': ':0', 11:26:54 INFO - 'HOME': '/home/cltbld', 11:26:54 INFO - 'LANG': 'en_US.UTF-8', 11:26:54 INFO - 'LANGUAGE': 'en_US:en', 11:26:54 INFO - 'LOGNAME': 'cltbld', 11:26:54 INFO - 'MAIL': '/var/mail/cltbld', 11:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:54 INFO - 'MOZ_NO_REMOTE': '1', 11:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:54 INFO - 'NO_EM_RESTART': '1', 11:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:54 INFO - 'PWD': '/builds/slave/test', 11:26:54 INFO - 'SHELL': '/bin/bash', 11:26:54 INFO - 'SHLVL': '1', 11:26:54 INFO - 'TERM': 'linux', 11:26:54 INFO - 'TMOUT': '86400', 11:26:54 INFO - 'USER': 'cltbld', 11:26:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:54 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:54 INFO - Downloading/unpacking psutil>=3.1.1 11: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 11: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 11: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 11: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 11:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:55 INFO - Installing collected packages: psutil 11:26:55 INFO - Running setup.py install for psutil 11:26:55 INFO - building 'psutil._psutil_linux' extension 11:26:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:26:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:26:56 INFO - building 'psutil._psutil_posix' extension 11:26:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:26:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:57 INFO - Successfully installed psutil 11:26:57 INFO - Cleaning up... 11:26:57 INFO - Return code: 0 11:26:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:26:57 INFO - Using env: {'DISPLAY': ':0', 11:26:57 INFO - 'HOME': '/home/cltbld', 11:26:57 INFO - 'LANG': 'en_US.UTF-8', 11:26:57 INFO - 'LANGUAGE': 'en_US:en', 11:26:57 INFO - 'LOGNAME': 'cltbld', 11:26:57 INFO - 'MAIL': '/var/mail/cltbld', 11:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:57 INFO - 'MOZ_NO_REMOTE': '1', 11:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:57 INFO - 'NO_EM_RESTART': '1', 11:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:57 INFO - 'PWD': '/builds/slave/test', 11:26:57 INFO - 'SHELL': '/bin/bash', 11:26:57 INFO - 'SHLVL': '1', 11:26:57 INFO - 'TERM': 'linux', 11:26:57 INFO - 'TMOUT': '86400', 11:26:57 INFO - 'USER': 'cltbld', 11:26:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:57 INFO - '_': '/tools/buildbot/bin/python'} 11:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11: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 11: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 11: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 11: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 11:26:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:58 INFO - Installing collected packages: mozsystemmonitor 11:26:58 INFO - Running setup.py install for mozsystemmonitor 11:26:58 INFO - Successfully installed mozsystemmonitor 11:26:58 INFO - Cleaning up... 11:26:58 INFO - Return code: 0 11:26:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11: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')]} 11:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:26:58 INFO - Using env: {'DISPLAY': ':0', 11:26:58 INFO - 'HOME': '/home/cltbld', 11:26:58 INFO - 'LANG': 'en_US.UTF-8', 11:26:58 INFO - 'LANGUAGE': 'en_US:en', 11:26:58 INFO - 'LOGNAME': 'cltbld', 11:26:58 INFO - 'MAIL': '/var/mail/cltbld', 11:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:58 INFO - 'MOZ_NO_REMOTE': '1', 11:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:58 INFO - 'NO_EM_RESTART': '1', 11:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:58 INFO - 'PWD': '/builds/slave/test', 11:26:58 INFO - 'SHELL': '/bin/bash', 11:26:58 INFO - 'SHLVL': '1', 11:26:58 INFO - 'TERM': 'linux', 11:26:58 INFO - 'TMOUT': '86400', 11:26:58 INFO - 'USER': 'cltbld', 11:26:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:58 INFO - '_': '/tools/buildbot/bin/python'} 11:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:00 INFO - warning: no files found matching '*.txt' 11:27:00 INFO - no previously-included directories found matching 'build' 11:27:00 INFO - no previously-included directories found matching 'dist' 11:27:00 INFO - no previously-included directories found matching '.git*' 11:27:00 INFO - Installing collected packages: jsonschema, functools32 11:27:00 INFO - Running setup.py install for functools32 11:27:01 INFO - warning: no files found matching '*.txt' 11:27:01 INFO - no previously-included directories found matching 'build' 11:27:01 INFO - no previously-included directories found matching 'dist' 11:27:01 INFO - no previously-included directories found matching '.git*' 11:27:01 INFO - Successfully installed jsonschema functools32 11:27:01 INFO - Cleaning up... 11:27:01 INFO - Return code: 0 11:27:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:27:01 INFO - Using env: {'DISPLAY': ':0', 11:27:01 INFO - 'HOME': '/home/cltbld', 11:27:01 INFO - 'LANG': 'en_US.UTF-8', 11:27:01 INFO - 'LANGUAGE': 'en_US:en', 11:27:01 INFO - 'LOGNAME': 'cltbld', 11:27:01 INFO - 'MAIL': '/var/mail/cltbld', 11:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:01 INFO - 'MOZ_NO_REMOTE': '1', 11:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:01 INFO - 'NO_EM_RESTART': '1', 11:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:01 INFO - 'PWD': '/builds/slave/test', 11:27:01 INFO - 'SHELL': '/bin/bash', 11:27:01 INFO - 'SHLVL': '1', 11:27:01 INFO - 'TERM': 'linux', 11:27:01 INFO - 'TMOUT': '86400', 11:27:01 INFO - 'USER': 'cltbld', 11:27:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:01 INFO - '_': '/tools/buildbot/bin/python'} 11:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:27:01 INFO - Cleaning up... 11:27:01 INFO - Return code: 0 11:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:27:01 INFO - Using env: {'DISPLAY': ':0', 11:27:01 INFO - 'HOME': '/home/cltbld', 11:27:01 INFO - 'LANG': 'en_US.UTF-8', 11:27:01 INFO - 'LANGUAGE': 'en_US:en', 11:27:01 INFO - 'LOGNAME': 'cltbld', 11:27:01 INFO - 'MAIL': '/var/mail/cltbld', 11:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:01 INFO - 'MOZ_NO_REMOTE': '1', 11:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:01 INFO - 'NO_EM_RESTART': '1', 11:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:01 INFO - 'PWD': '/builds/slave/test', 11:27:01 INFO - 'SHELL': '/bin/bash', 11:27:01 INFO - 'SHLVL': '1', 11:27:01 INFO - 'TERM': 'linux', 11:27:01 INFO - 'TMOUT': '86400', 11:27:01 INFO - 'USER': 'cltbld', 11:27:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:01 INFO - '_': '/tools/buildbot/bin/python'} 11:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:27:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11: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 11: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 11: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 11: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 11:27:03 INFO - Downloading docopt-0.6.1.tar.gz 11:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:03 INFO - Running setup.py install for blobuploader 11:27:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:03 INFO - Running setup.py install for requests 11:27:03 INFO - Running setup.py install for docopt 11:27:03 INFO - Successfully installed blobuploader requests docopt 11:27:03 INFO - Cleaning up... 11:27:03 INFO - Return code: 0 11:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:03 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 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:03 INFO - Using env: {'DISPLAY': ':0', 11:27:03 INFO - 'HOME': '/home/cltbld', 11:27:03 INFO - 'LANG': 'en_US.UTF-8', 11:27:03 INFO - 'LANGUAGE': 'en_US:en', 11:27:03 INFO - 'LOGNAME': 'cltbld', 11:27:03 INFO - 'MAIL': '/var/mail/cltbld', 11:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:03 INFO - 'MOZ_NO_REMOTE': '1', 11:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:03 INFO - 'NO_EM_RESTART': '1', 11:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:03 INFO - 'PWD': '/builds/slave/test', 11:27:03 INFO - 'SHELL': '/bin/bash', 11:27:03 INFO - 'SHLVL': '1', 11:27:03 INFO - 'TERM': 'linux', 11:27:03 INFO - 'TMOUT': '86400', 11:27:03 INFO - 'USER': 'cltbld', 11:27:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:03 INFO - '_': '/tools/buildbot/bin/python'} 11:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:04 INFO - Running setup.py (path:/tmp/pip-vE7flh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:04 INFO - Running setup.py (path:/tmp/pip-GDDZWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:04 INFO - Running setup.py (path:/tmp/pip-dJmIMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:04 INFO - Running setup.py (path:/tmp/pip-DddpmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:04 INFO - Running setup.py (path:/tmp/pip-c85Osm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:04 INFO - Running setup.py (path:/tmp/pip-e1WOQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:04 INFO - Running setup.py (path:/tmp/pip-SRKrfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:04 INFO - Running setup.py (path:/tmp/pip-be0hVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:04 INFO - Running setup.py (path:/tmp/pip-S68u34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:04 INFO - Running setup.py (path:/tmp/pip-26iSFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:04 INFO - Running setup.py (path:/tmp/pip-SxAbN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:04 INFO - Running setup.py (path:/tmp/pip-hKafh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:04 INFO - Running setup.py (path:/tmp/pip-OYNDnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:04 INFO - Running setup.py (path:/tmp/pip-B6UwY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:05 INFO - Running setup.py (path:/tmp/pip-IcYWJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:05 INFO - Running setup.py (path:/tmp/pip-Fzi1xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:05 INFO - Running setup.py (path:/tmp/pip-6ZAHKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:05 INFO - Running setup.py install for manifestparser 11:27:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:05 INFO - Running setup.py install for mozcrash 11:27:05 INFO - Running setup.py install for mozdebug 11:27:05 INFO - Running setup.py install for mozdevice 11:27:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:05 INFO - Running setup.py install for mozfile 11:27:05 INFO - Running setup.py install for mozhttpd 11:27:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:05 INFO - Running setup.py install for mozinfo 11:27:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:05 INFO - Running setup.py install for mozInstall 11:27:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Running setup.py install for mozleak 11:27:06 INFO - Running setup.py install for mozlog 11:27:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Running setup.py install for moznetwork 11:27:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Running setup.py install for mozprocess 11:27:06 INFO - Running setup.py install for mozprofile 11:27:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Running setup.py install for mozrunner 11:27:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Running setup.py install for mozscreenshot 11:27:06 INFO - Running setup.py install for moztest 11:27:06 INFO - Running setup.py install for mozversion 11:27:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:06 INFO - Cleaning up... 11:27:07 INFO - Return code: 0 11:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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')]} 11:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11: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')]} 11:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:07 INFO - Using env: {'DISPLAY': ':0', 11:27:07 INFO - 'HOME': '/home/cltbld', 11:27:07 INFO - 'LANG': 'en_US.UTF-8', 11:27:07 INFO - 'LANGUAGE': 'en_US:en', 11:27:07 INFO - 'LOGNAME': 'cltbld', 11:27:07 INFO - 'MAIL': '/var/mail/cltbld', 11:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:07 INFO - 'MOZ_NO_REMOTE': '1', 11:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:07 INFO - 'NO_EM_RESTART': '1', 11:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:07 INFO - 'PWD': '/builds/slave/test', 11:27:07 INFO - 'SHELL': '/bin/bash', 11:27:07 INFO - 'SHLVL': '1', 11:27:07 INFO - 'TERM': 'linux', 11:27:07 INFO - 'TMOUT': '86400', 11:27:07 INFO - 'USER': 'cltbld', 11:27:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:07 INFO - '_': '/tools/buildbot/bin/python'} 11:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:07 INFO - Running setup.py (path:/tmp/pip-xi2fqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:07 INFO - Running setup.py (path:/tmp/pip-8XSSfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:07 INFO - Running setup.py (path:/tmp/pip-ycMnEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:07 INFO - Running setup.py (path:/tmp/pip-ODnO_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:07 INFO - Running setup.py (path:/tmp/pip-cnKnl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:07 INFO - Running setup.py (path:/tmp/pip-BFPuhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:07 INFO - Running setup.py (path:/tmp/pip-cCsoDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:07 INFO - Running setup.py (path:/tmp/pip-2WUXC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:07 INFO - Running setup.py (path:/tmp/pip-PdTfYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:07 INFO - Running setup.py (path:/tmp/pip-HCJlwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:07 INFO - Running setup.py (path:/tmp/pip-XH8t1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:08 INFO - Running setup.py (path:/tmp/pip-ojFEpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:08 INFO - Running setup.py (path:/tmp/pip-HblN0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:08 INFO - Running setup.py (path:/tmp/pip-08lID5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:08 INFO - Running setup.py (path:/tmp/pip-rCNqAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:08 INFO - Running setup.py (path:/tmp/pip-ruBTJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:08 INFO - Running setup.py (path:/tmp/pip-gyQjrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:27:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:09 INFO - Downloading blessings-1.6.tar.gz 11:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:09 INFO - Installing collected packages: blessings 11:27:09 INFO - Running setup.py install for blessings 11:27:09 INFO - Successfully installed blessings 11:27:09 INFO - Cleaning up... 11:27:09 INFO - Return code: 0 11:27:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:10 INFO - Reading from file tmpfile_stdout 11:27:10 INFO - Current package versions: 11:27:10 INFO - argparse == 1.2.1 11:27:10 INFO - blessings == 1.6 11:27:10 INFO - blobuploader == 1.2.4 11:27:10 INFO - docopt == 0.6.1 11:27:10 INFO - functools32 == 3.2.3-2 11:27:10 INFO - jsonschema == 2.5.1 11:27:10 INFO - manifestparser == 1.1 11:27:10 INFO - mozInstall == 1.13 11:27:10 INFO - mozcrash == 1.0 11:27:10 INFO - mozdebug == 0.1 11:27:10 INFO - mozdevice == 0.51 11:27:10 INFO - mozfile == 1.2 11:27:10 INFO - mozhttpd == 0.7 11:27:10 INFO - mozinfo == 0.10 11:27:10 INFO - mozleak == 0.1 11:27:10 INFO - mozlog == 3.5 11:27:10 INFO - moznetwork == 0.27 11:27:10 INFO - mozprocess == 0.25 11:27:10 INFO - mozprofile == 0.28 11:27:10 INFO - mozrunner == 6.13 11:27:10 INFO - mozscreenshot == 0.1 11:27:10 INFO - mozsystemmonitor == 0.3 11:27:10 INFO - moztest == 0.8 11:27:10 INFO - mozversion == 1.4 11:27:10 INFO - psutil == 3.1.1 11:27:10 INFO - requests == 1.2.3 11:27:10 INFO - wsgiref == 0.1.2 11:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:10 INFO - Using env: {'DISPLAY': ':0', 11:27:10 INFO - 'HOME': '/home/cltbld', 11:27:10 INFO - 'LANG': 'en_US.UTF-8', 11:27:10 INFO - 'LANGUAGE': 'en_US:en', 11:27:10 INFO - 'LOGNAME': 'cltbld', 11:27:10 INFO - 'MAIL': '/var/mail/cltbld', 11:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:10 INFO - 'MOZ_NO_REMOTE': '1', 11:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:10 INFO - 'NO_EM_RESTART': '1', 11:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:10 INFO - 'PWD': '/builds/slave/test', 11:27:10 INFO - 'SHELL': '/bin/bash', 11:27:10 INFO - 'SHLVL': '1', 11:27:10 INFO - 'TERM': 'linux', 11:27:10 INFO - 'TMOUT': '86400', 11:27:10 INFO - 'USER': 'cltbld', 11:27:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:10 INFO - '_': '/tools/buildbot/bin/python'} 11:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:27:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:27:11 INFO - Installing collected packages: simplejson 11:27:11 INFO - Running setup.py install for simplejson 11:27:11 INFO - building 'simplejson._speedups' extension 11:27:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:27:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:27:12 INFO - Successfully installed simplejson 11:27:12 INFO - Cleaning up... 11:27:12 INFO - Return code: 0 11:27:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:12 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 0x104f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1218a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, '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': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:27:12 INFO - Using env: {'DISPLAY': ':0', 11:27:12 INFO - 'HOME': '/home/cltbld', 11:27:12 INFO - 'LANG': 'en_US.UTF-8', 11:27:12 INFO - 'LANGUAGE': 'en_US:en', 11:27:12 INFO - 'LOGNAME': 'cltbld', 11:27:12 INFO - 'MAIL': '/var/mail/cltbld', 11:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:12 INFO - 'MOZ_NO_REMOTE': '1', 11:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:12 INFO - 'NO_EM_RESTART': '1', 11:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:12 INFO - 'PWD': '/builds/slave/test', 11:27:12 INFO - 'SHELL': '/bin/bash', 11:27:12 INFO - 'SHLVL': '1', 11:27:12 INFO - 'TERM': 'linux', 11:27:12 INFO - 'TMOUT': '86400', 11:27:12 INFO - 'USER': 'cltbld', 11:27:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:12 INFO - '_': '/tools/buildbot/bin/python'} 11:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:12 INFO - Cleaning up... 11:27:12 INFO - Return code: 0 11:27:12 INFO - Running post-action listener: _resource_record_post_action 11:27:12 INFO - Running post-action listener: _start_resource_monitoring 11:27:12 INFO - Starting resource monitoring. 11:27:12 INFO - [mozharness: 2017-09-22 18:27:12.798927Z] Finished create-virtualenv step (success) 11:27:12 INFO - [mozharness: 2017-09-22 18:27:12.799384Z] Running install step. 11:27:12 INFO - Running pre-action listener: _resource_record_pre_action 11:27:12 INFO - Running main action method: install 11:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:13 INFO - Reading from file tmpfile_stdout 11:27:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:13 INFO - Reading from file tmpfile_stdout 11:27:13 INFO - Output received: 11:27:13 INFO - Usage: mozinstall [options] installer 11:27:13 INFO - Options: 11:27:13 INFO - -h, --help show this help message and exit 11:27:13 INFO - -d DEST, --destination=DEST 11:27:13 INFO - Directory to install application into. [default: 11:27:13 INFO - "/builds/slave/test"] 11:27:13 INFO - --app=APP Application being installed. [default: firefox] 11:27:13 INFO - mkdir: /builds/slave/test/build/application 11:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:27:30 INFO - Reading from file tmpfile_stdout 11:27:30 INFO - Output received: 11:27:30 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:30 INFO - Running post-action listener: _resource_record_post_action 11:27:30 INFO - [mozharness: 2017-09-22 18:27:30.958136Z] Finished install step (success) 11:27:30 INFO - [mozharness: 2017-09-22 18:27:30.958394Z] Running setup-mitmproxy step. 11:27:30 INFO - Running pre-action listener: _resource_record_pre_action 11:27:30 INFO - Running main action method: setup_mitmproxy 11:27:30 INFO - Skipping: mitmproxy is not required 11:27:30 INFO - Running post-action listener: _resource_record_post_action 11:27:30 INFO - [mozharness: 2017-09-22 18:27:30.959532Z] Finished setup-mitmproxy step (success) 11:27:30 INFO - [mozharness: 2017-09-22 18:27:30.959754Z] Running run-tests step. 11:27:30 INFO - Running pre-action listener: _resource_record_pre_action 11:27:30 INFO - Running pre-action listener: _set_gcov_prefix 11:27:30 INFO - Running main action method: run_tests 11:27:30 WARNING - Try message not found. 11:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:30 INFO - Python 2.7.3 11:27:30 INFO - Return code: 0 11:27:30 INFO - grabbing minidump binary from tooltool 11:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:30 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 0x13bf090>, '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 0x13bfd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:30 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 11:27:30 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 11:27:30 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 11:27:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:31 INFO - Return code: 0 11:27:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:31 INFO - ENV: RUST_BACKTRACE is now full 11:27:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 11:27:31 INFO - Using env: {'DISPLAY': ':0', 11:27:31 INFO - 'HOME': '/home/cltbld', 11:27:31 INFO - 'LANG': 'en_US.UTF-8', 11:27:31 INFO - 'LANGUAGE': 'en_US:en', 11:27:31 INFO - 'LOGNAME': 'cltbld', 11:27:31 INFO - 'MAIL': '/var/mail/cltbld', 11:27:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:31 INFO - 'MOZ_NO_REMOTE': '1', 11:27:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:31 INFO - 'NO_EM_RESTART': '1', 11:27:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:31 INFO - 'PWD': '/builds/slave/test', 11:27:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:31 INFO - 'RUST_BACKTRACE': 'full', 11:27:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:31 INFO - 'SHELL': '/bin/bash', 11:27:31 INFO - 'SHLVL': '1', 11:27:31 INFO - 'TERM': 'linux', 11:27:31 INFO - 'TMOUT': '86400', 11:27:31 INFO - 'USER': 'cltbld', 11:27:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:31 INFO - '_': '/tools/buildbot/bin/python'} 11:27:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:27:31 INFO - mozversion application_buildid: 20170922173423 11:27:31 INFO - mozversion application_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:27:31 INFO - mozversion application_display_name: Nightly 11:27:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:31 INFO - mozversion application_name: Firefox 11:27:31 INFO - mozversion application_remotingname: firefox 11:27:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:27:31 INFO - mozversion application_vendor: Mozilla 11:27:31 INFO - mozversion application_version: 58.0a1 11:27:31 INFO - mozversion platform_buildid: 20170922173423 11:27:31 INFO - mozversion platform_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:27:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:27:31 INFO - mozversion platform_version: 58.0a1 11:27:31 INFO - using testdate: 1506104851 11:27:31 INFO - actual date: 1506104851 11:27:31 INFO - starting webserver on 'localhost:58686' 11:27:31 INFO - SUITE-START | Running 2 tests 11:27:31 INFO - TEST-START | dromaeo_css 11:27:31 INFO - Initialising browser for dromaeo_css test... 11:27:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58686/getInfo.html -profile /tmp/tmp1pE8Jm/profile 11:27:31 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox http://localhost:58686/getInfo.html) 11:27:37 INFO - TEST-INFO | 3574: exit 0 11:27:37 INFO - Browser initialized. 11:27:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:37 INFO - Using env: {'DISPLAY': ':0', 11:27:37 INFO - 'HOME': '/home/cltbld', 11:27:37 INFO - 'JSGC_DISABLE_POISONING': '1', 11:27:37 INFO - 'LANG': 'en_US.UTF-8', 11:27:37 INFO - 'LANGUAGE': 'en_US:en', 11:27:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:27:37 INFO - 'LOGNAME': 'cltbld', 11:27:37 INFO - 'MAIL': '/var/mail/cltbld', 11:27:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:27:37 INFO - 'MOZ_NO_REMOTE': '1', 11:27:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:37 INFO - 'NO_EM_RESTART': '1', 11:27:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:37 INFO - 'PWD': '/builds/slave/test', 11:27:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:37 INFO - 'RUST_BACKTRACE': 'full', 11:27:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:37 INFO - 'SHELL': '/bin/bash', 11:27:37 INFO - 'SHLVL': '1', 11:27:37 INFO - 'STYLO_FORCE_DISABLED': '1', 11:27:37 INFO - 'TERM': 'linux', 11:27:37 INFO - 'TMOUT': '86400', 11:27:37 INFO - 'USER': 'cltbld', 11:27:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:37 INFO - '_': '/tools/buildbot/bin/python'} 11:27:37 INFO - TEST-INFO | started process 3805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pE8Jm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:38 INFO - PID 3805 | 11:27:38 INFO - PID 3805 | (/builds/slave/test/build/application/firefox/firefox:3854): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:27:38 INFO - PID 3805 | 11:27:48 INFO - PID 3805 | RSS: Main: 153210880 11:27:48 INFO - PID 3805 | 11:30:45 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58686/tests/dromaeo/cssquery-ext.html) 11:30:46 INFO - PID 3805 | RSS: Main: 153890816 11:30:46 INFO - PID 3805 | 11:33:48 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-ext.html (next: http://localhost:58686/tests/dromaeo/cssquery-jquery.html) 11:33:49 INFO - PID 3805 | RSS: Main: 152559616 11:33:49 INFO - PID 3805 | 11:36:50 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58686/tests/dromaeo/cssquery-mootools.html) 11:36:51 INFO - PID 3805 | RSS: Main: 154595328 11:36:51 INFO - PID 3805 | 11:39:53 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58686/tests/dromaeo/cssquery-prototype.html) 11:39:53 INFO - PID 3805 | RSS: Main: 154636288 11:39:53 INFO - PID 3805 | 11:42:56 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58686/tests/dromaeo/cssquery-yui.html) 11:42:57 INFO - PID 3805 | RSS: Main: 155275264 11:42:57 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:58686/tests/dromaeo/cssquery-yui.html (next: http://localhost:58686/tests/dromaeo/cssquery-dojo.html) 11:45:59 INFO - PID 3805 | RSS: Main: 157995008 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | __start_tp_report 11:45:59 INFO - PID 3805 | _x_x_mozilla_page_load 11:45:59 INFO - PID 3805 | _x_x_mozilla_page_load_details 11:45:59 INFO - PID 3805 | |i|pagename|runs| 11:45:59 INFO - PID 3805 | |0;dojo.html;3083.722464978152;3109.3781243751255;3164.019154062241;3171.0328349853294;3187.792793468423;6389.520785941049;6418.614883107005;6447.258565264996;6464.3212462691445;6492.480601551876;6198.318184999646;6295.937040629592;6342.904856427146;6494.480441564675;6527.151470308853;5872.265966754156;5878.441548052928;5971.880562388749;5988.880222395549;6058.3032951210735;5702.344230413493;5726.169705392736;5763;5847.766089356442;5854.88290234195;5809.419058094199;5831.446012628793;5834.708264586754;5866.560007999417;5901.793437229698;5677.659340439545;5746.626469279484;5794.768209271666;5807.070868660994;5831.737571809279;5773.740181691834;5875.383084776123;5897.6166549174595;5934.258217722785;5936.050231962865;6339.651319177444;6363.7454501819875;6422.646754428504;6431.807045788634;6478.384553467413;6677;6744.123263975701;6819.556728812611;6927.930720692779;6934.861302773967;6732.427743641796;6815.454763618898;6884.1050663413935;6886.345797149263;6887.449004079662;6379.106925030499;6394.712237949257;6448.967755161194;6459.709313080923;6466.80599582018;6837.760678376233;6900.413464855544;6915.101036865175;6938.340857618518;7064.92935070653;6609.372109649576;6647.501437392215;6653.73385064592;6681.09805176295;6700.798976030727;6871.209810871714;6884.449244060464;6975.79072627822;6982.092327997328;6985.89521157183;6752.93247067523;6865.41643960259;6946.930530694628;6948.513604047769;6961.65191740411;6649.368310010638;6909.550879192836;6914.688839002257;6999.370056694922;7003.614801185881;5337.599680024014;5337.733113344318;5339.733013349317;5345.3852806926925;5379.462053794668;4691.859244222679;4711.104890070876;4736.5973892219545;4748.430188377348;4819.759012049383;5884.676342801102;5894.351621321651;5949.940500594938;5967.224260846062;5980.43185897339;6954.513184077066;6968.512204145763;7031.437485001187;7039.964800175966;7061.752838650623;5679.8864022720145;5789.45000224978;5793.275840519935;5799.507041901401;5926.348101708809;5812.331581868055;5841.357450680422;5888.970555147197;5894.528437724972;5897.616654917502;6618.271990081087;6634.800955971328;6756.2568117507035;6757.662116894136;6759.662016899136;6938.306169383021;6941.687624057031;7020.05229294049;7029.05107810439;7046.5419747715205;6389.87220255583;6483.092367068709;6615.801525954229;6655.73377064912;6742.561733487308;6704.765333213314;6750.966245168743;6760.290169532128;6774.559653622498;6776.898346524905;6879.346462086094;6908.585484870924;7035.261297563682;7055.506114571931;7056.929430705627;6670.533062685566;6672.03255527936;6682.63245521501;6762.932370676427;6767.35710107539;6451.580647258101;6562.376574225441;6682.866342673216;6783.626900520519;6784.626845523544;6519.6088234704175;6603;6603.933960660332;6605.834854128493;6606.042123892104;6747.359000894907;6761.425278851353;6802.727890884309;6837.555558888656;6860.3139686031;6523.3476652336285;6525.575837570543;6532.248791389051;6621.172353455818;6638.867222655616 11:45:59 INFO - PID 3805 | |1;ext.html;855.4653341661461;880.2517859819154;904.8868891388574;906.5829718329568;907.4464576608268;39138;39938.600613993854;39943.201135977266;39949.60050399495;39965.60034399651;37417.43873841895;39508.407373889415;40047.59952400475;40133.397999030036;40134.39798403019;7902.604869756504;8002.119766825645;8039.55782431966;8062.838743225132;8065.233802788725;7889.487183333065;8003.559804210766;8011.67953281868;8015.879761803578;8030.879536806952;8060.274575288223;8061.838763224732;8078.151794061627;8117.269445749881;8121.431499795017;8020.157883422245;8042.638081286356;8060;8064.516129032248;8080;7879.527228366259;7902.4863383879865;7916.406269529808;7930.246626570467;7971.521708697497;38177.23645527074;38264.42603360952;38286.80856595727;38458;38543.22913541713;3543;3581;3582.659647333499;3590.9461358079648;3601.099725068733;31141.532877006863;31318.530222046687;31396.686033139606;31469.213269668213;31477.685223147935;4980.651354405193;5122.359705036871;5174.948250517485;5201.427842937273;5221.71280579568;190802;193494;193874;195179.02410488;195433;47944.760276198394;48396.7580162104;48477;48626.27060594094;48923.02153956901;49994.250086248736;50007;50143.74928125336;50169;50386.49613503818;14315.57053288403;14447.85552144486;14471.059381140403;14475.855241447662;14524.128552286897;11470.082393408507;11546.884531154581;11563.88436115645;11567.132465065153;11586.073114150848;13032.087753857139;13079.673008174681;13090.08369414151;13193.076484645982;13297.3351332433;5322.627416080837;5433.239346491494;5437.8368648940595;5447.400785913546;5495;1003.2225025605214;1016.9186465082776;1024.1704219582161;1035.8705161854768;1037.234837539726;22465.663015054786;22505;22695.432614184447;22901.08395664155;23282.185123520594;1107.1530279336314;1110.8613670987302;1113.3820729495046;1123.584273818676;1136.4885801389407;11986;12200.511979520898;12234.632961011184;12263.570775022832;12269.815952760715;226284;227461;228371;229276;229341;50724;50760.49239507558;51049.744751276005;51169.74415127975;51218.48781512137;1455.5487798782624;1459.1755658053378;1482.8739557137549;1488.3823213366331;1497.3561368611602;22316.330510084725;22391.77608223962;22683.886580566992;22863.542729145658;22900.770992289865;36056.4591531122;36173.27653446969;36184.27631447409;36251.45622815713;36257.63742362543;193388;193509;194000;194163;194227;29900.70099298979;30499.54250686197;33562.32875342528;33663.326733465685;33743;41075.58924410837;41906.58093419149;42191.57808421999;42406.57593424026;42996;30592.235194120323;31015.379692406477;31805.36389272248;31931.521027185074;32295.35409291848;30710.539341910335;31192.53211201879;31285;31562.526562101128;31705.841470792497;35186.648133518334;35190.47214291839;35402.29195416026;35511.46732799062;35646.64353356433;30852.22869428282;31016.844915775277;31254.843725781226;31303.84348078245;31378;22304.553908922055;23096.4225894354;23329.3001209964;23336.183233586744;23820.761792381854 11:45:59 INFO - PID 3805 | |2;jquery.html;590.347665829259;592.2862950145076;594.506559555569;609.5763444406139;614.2444792904727;21957.67063494047;22725.886370568165;22740.204092856755;22766.203182888603;22781.202657906975;23454.41363965902;24092.277231683078;25452;25516;25567.74432255677;6582.111414958991;6635.037919501669;6701.932980670204;6735.32646735325;6739.966300168492;6459.289478157399;6562.212534495843;6638.369354911276;6674.599524028549;6748.190217173946;6705.865882682343;6737.528373013891;6740.797776066702;6743.15710536183;6749.223839258474;6393.392627700361;6689.632070236135;6702.631355275458;6725.932740672604;6737.831554211135;6208.006718924996;6211;6212.502999760009;6230.813075607739;6240.968795156041;27345.86327068372;27666.861665691744;27676.723232767617;27794.583081253797;27875;2032.5121970727066;2039.1333683184587;2057.022914115783;2060.124447109972;2062.226665000625;19605;19787.40637780869;20209.595808083905;20446.38660840177;20528.178872845067;2473.3692908308444;2478.021181633245;2532.8353657012235;2536.6195070739354;2543.9491210175693;117319;121708.39145804214;126513;131149;132006.3399683005;14792.928989941416;15051.93597728629;15227.467038653594;15357.155356455502;15398.229203641724;23129.537409252058;23228;23231.419214519774;23294.417639559146;23383.181588644657;10190.592376304865;10311.690649280534;10422.583096676048;10458.790824183474;10521;9442.244620430349;9500.8623059811;9513.381630194015;9613.471259080678;9753.122219000183;9254.953725231466;9295.76760580991;9672.613095476243;10038.19694424459;10490.370577765358;2724.223596275052;2753.3231912611836;2837.4608824323313;2897.6377952755906;2957.8816847325866;948.5020364308655;966.990330096704;967.5307475874196;975.1857199238574;981.8625392445064;18972.905135474233;19163.61672766537;19212.135453904328;19299;19615.313464028975;1016.2428990402198;1016.6645007147623;1020.9234307426824;1021.6066814276558;1035.2442716816765;10562.841557376645;10587.57649694019;10686.679399618024;10725.195610329101;11022.173336999756;459334;460768;470566;471654;475501;105589.47205263925;107461.46269268604;108642;108780;109634;1171.4142928535732;1196.407778149804;1196.6410076976872;1196.9880301197052;1200.855897292313;16836.915815421333;17070.658586828442;17312.047837368562;17388.739168912223;17410.825891740922;52862;53073;53420.73289633527;53469.46530534645;54468;64681.35318646753;64713.35286647262;65109.67445162744;65616.34383656293;65905.67047164733;14144.43422263098;14365.92817035908;14452.277386130441;14616.926915365355;14620.634484137981;22377.44056398603;22390.77609223887;22443.88778056099;22509.88745056264;22511.09955601823;17442.651146976736;17920.283188672307;17928.91035544866;18329.266829326676;18336.358227461973;15400.152991585122;15723.764143537628;15896.761548577011;16597.336106555602;16657.750133748246;18328.81671183271;18453.446396608124;18768.812311876707;18781.34265300708;18854.905725471286;14226.786598200828;14260.144391336553;14260.358283877044;14300.570982870531;14325.713485730435;17766.733498997266;17918.91040544789;17920.283188672307;17955.910220448815;18133.727994080364 11:45:59 INFO - PID 3805 | |3;mootools.html;1294.9676258093546;1333.293354522103;1345.2466618693531;1353.8578449262834;1354.018336705889;12825.615231543057;13381.197128172304;13447.19316840989;15787.28957196926;16239.106849123293;15566.533004009869;15910.284037218324;15919.124448155348;15938.28277727502;15963.281652325644;2825.152454263723;2861.399106187703;2905.680375158731;2907.592936988823;2918.8540572971374;2837.7020412856664;2872.6840047594746;2872.956905646417;2874.4538537677877;2876.7698584113327;2630.842149471038;2674.933126671829;2679.4105296834664;2824.265690920365;2886.7113288671176;2754.5868119781994;2772.6811416686937;2776.250412388654;2780.138157171273;2790.344269096761;2703.9188824335106;2732.49448851963;2752.3394385347574;2752.4907892039837;2755.641766570353;15186.088834669956;15583.220838958006;15651.295691693902;15712;15758.290876910567;8193.590320483952;8457.788555286106;8460.619272132768;8463.4075614707;8473.49159050459;5288.260479936259;5399.946000539983;5590.496855283044;5591.245181900432;5659.066254068074;1872.6161136967025;1973.15154483572;1975.1803001754254;1997.7602687677572;2004.0781240629328;27112.186634400998;27170.777315020674;27276.590851137247;27286.727132728814;27310.863445682844;6822.522423430312;7000.404965577881;7040.859182816417;7247.528910620793;7267.236940121317;17432.38986635487;17472.912635436995;17483.825161748475;17544;17592.208350624252;8556.871646925301;8849.4247873888;8854.29165666745;8859.936807583132;8870.467771933576;6029.879402411927;6753.1220941277315;7830.960845195737;7870.881936770953;7900.841983160304;5081.923771143436;5249.790008399697;5266;5275.57795376369;5324.946750532523;1621.3190460006826;1658;1665.875059370552;1681.4955513345947;1684.351524662989;829.4111181061394;851.1956201389751;862.4523427623504;869.573908784691;880.0891077734514;7034.331738484836;7065.540739851893;7067.71729130829;7090.751823686146;7099.183593886666;717.9784606461815;726.4224941171781;732.9780106596811;734.1263895963785;737.789729926979;4787.952120478751;4900.558949694545;5087.465816089331;5269.104252277122;5274.4198138204765;20738;21515.13939442436;21889.781102188776;22086.779132208794;22159.556808863734;20438.69341959872;21211.893940530506;21496.462588435414;21527.67708484374;21573.67639485409;11536.808006478743;11539.653810385535;11690.532378704927;11742.647720568397;11796.882031179579;7972.322352599862;8085.9595702021115;8102.3899959678065;8224.342052635895;8257.917420825715;18631.627367452846;18699.195120731998;19076;19095;19216.61566768685;19741;19862.205511779946;19923.800761992195;20471.4882127948;20693;11174;11231.887681123084;11329.263597866113;11368.54525818958;11373.090152787592;14106.506272280421;14317.713645726819;14334.426622934965;14336.354864030935;14346.928265358607;10908.34549927007;10959.726006849893;11125.44372781374;11180.329180249211;11418.657440276806;11214.102871770401;11310.434478276218;11356.659300221007;11600.245984011011;11675;9601.567929443332;9697.854532182164;9722.076402741728;9723.416595004323;9726.756831078996;7441.255874412515;7477.969281743625;7531.472796904164;7551.962240188984;7580.810479738051;6913.308669133247;6982.197047339621;7035.050268213726;7092.04257425241;7218.566885986857 11:45:59 INFO - PID 3805 | |4;prototype.html;498.34716521357024;505.8264825604599;519.8648351428627;534.6845361236869;548.4926443040188;6396.392342727445;6416.3262857400005;6462.870742585145;6480.902786458207;6511;6238.563300568962;6253.24961004679;6296.244450665915;6312.431881130698;6348.650824204667;5279.99999999999;5280.128778751501;5285.339332583427;5295.841124766263;5309.33633295838;4931.556159945604;5236.895262094756;5328.1474964005765;5330.813421530247;5360.839174824742;5028.2709007193935;5043.949560504385;5066.442691303953;5072.594192464594;5082.467684958955;5071.112555302807;5071.366079240095;5077.136886729265;5129.589632829365;5133.845984620468;4558.635309175258;4593.333966574828;4609.101225261075;4610.077984403133;4612.607928326096;6246.281677607088;6247.62514249142;6283.465905398047;6293.748250069992;6323.557350985433;5823.845177284389;5845.883082338372;5868.76524939002;5877.032098790126;5886.8822623547285;6513.153290072308;6597.538172327939;6635.834104147387;6677.465802735769;6706.161729783777;4941.901161976741;4949.307097006422;4962.660081777936;4982.825601103944;4985.077760614262;6607.768728094542;6797.286284940109;6904.273931517121;6929.203141638675;7001.929980700179;5074.264231686385;5076.898462030738;5099.337086178847;5111.897762044812;5142.331496905454;5132.563732082815;5165.199394093921;5185.429602743695;5192.948070519246;5194.870128246824;5692.117721753135;5775.913361299584;5788.797392091256;5796.333421656479;5820.708964551755;6674.699638516278;6709.6980635871505;6724.9327506725285;6725.192976842713;6781.355771201728;1761.3218910719208;1777.5911540345792;1786.0801687131138;1786.642671465712;1803.1885651456896;1156.3986726902133;1229.434460148324;1243.154654834721;1257.2896313582796;1267.518343029643;5646.193218170146;5657.717114144276;5685.9480996015045;5761.452661997104;5765.279340082489;6663.433608143265;6676.365745254193;6747.257801641816;6766.763163289262;6827.780971184385;5690.459406356389;5701.144828275792;5708.257926469532;5716.314042314865;5736.311642602915;3570.625084366156;3575.2313252650806;3603.94594081089;3632.8728494502566;3634.400323946572;6217.316095229521;6408.455281301141;6434.935650643433;6466;6501.934980650228;6775.017622444718;6822.420094292041;6893.93106068943;6902.516823822284;6943.409810166091;6342.2072240968955;6437.67811609427;6445.581037232565;6481.643509606923;6522.119513865568;6755.1423358576785;6794.456443484608;6810.557313774589;6844.315568443116;6901.654917254217;6760.93239067603;6764.797056088325;6781.457483401415;6801.659917004229;6815.522913396015;6471.611703297817;6528.183977002875;6533.477321814338;6579.276279609335;6586.703598338182;5064.316317297265;5084.8897707451;5090.490950905028;5136.229565565195;5150.768215430239;6500.187476565429;6676.432503237279;6719.563228390334;6733.3939945405145;6734.191896972395;6458.257300410325;6511.37215696076;6603.20761508622;6619.304972977768;6680.164979377578;6457.903131452938;6549.803505894831;6554.311797261219;6578.934210657832;6584.473242140713;6459.257185423737;6541.08424820516;6552;6568.441682456853;6580.868382632416;6667.733290668319;6679.8664026718225;6712.127423434922;6733.3939945405145;6817.250102488623;6417.550771446141;6467.159269294962;6475.125858009108;6505.902411463927;6510.576812507361 11:45:59 INFO - PID 3805 | |5;yui.html;896.8789213456181;919.0717375450795;928.011667574034;934.3833070173682;948.0898337595908;19044.14301356439;20101.798982010176;20121.798782012174;20158.798412015876;20201.292954746586;17993.640127197446;18138.909305453486;18481;18847.15187816548;18977.33579324724;954.6801821389843;973.9123478886899;977.4135518688801;977.5454413697629;977.8142152990908;965.75856035991;970.4565443351746;978.3151793744372;980.4607465893765;1003.2425518733346;1065.046783129099;1067.0983019348637;1067.4395942130366;1067.7063807452935;1068.4123731947436;1003.7590978165188;1045.900639439252;1047.9056884880358;1051.626672531248;1051.6897515232986;755.8866170074477;760.6919197724931;762.8931949527071;762.9885551716728;763.6296396247816;19660.311889083958;19685.80314196854;19781.9010904946;19825.206991720315;19833.60332793336;21310.573788524296;21317.893410533004;22092.226772062902;22304.107835686555;22328.55342893133;17298.91350543252;17586.91206543972;17654.382096626683;17661.823381766146;17803.643927121386;3491.2319289756215;3528.5060091587197;3535.5580552430947;3539.2213712983103;3539.752217344787;140128.29935850357;140286;142304;145303.2734836319;145521;16871.325146993982;17051.147442628066;17126.657466850593;17204.91397543004;17234.482965511055;31143.844280778452;31642.683573163973;32117.35765284681;32189.356212875613;32493.837530812667;8446.493210407396;8500.787480312918;8501.319894408556;8538.231559159582;8545.145485451405;4337.240982827992;4400.361947517592;4463.062756821039;4503.076869241798;4521;5639.238702775155;5739.426057394227;5750.597458177971;5776.42235776419;5783.508401785895;990.8464188050864;997.2769741937037;1015.1777060580953;1020.3622735790132;1022.8465730140539;647.7506160128385;649.7953144759385;660.7291010685692;663.2704025571928;678.966051697423;10615.31000484966;10711.410872401937;10735.194860385502;11173.441327933733;11731.120165987584;685.7120009595982;688.5317983771084;692.4806395203598;699.3286445012844;706.4101475268106;5408.621396502207;5416.8104116355735;5486.506214440719;5512.5314348280845;5570.6657600543285;121296;127483;128195.35902320615;128845;130208;103869;105096;106271;106948;108224.45887770511;86247.56876215579;86264.56867715622;87537;87556;88099.55950220207;10035.448050357008;10063.295569310078;10071.244656650928;10121.797564048826;10228.312328466018;43350;43409.565904340554;43780.34329484997;44326.77836610797;44449.333260001775;53842.192367115305;55288;56697;56973;57618.13572796495;13767.449302027806;13876.236806975714;13941.233232172328;14114.576562703136;14133.929330353283;16456.67086658284;16667.66664666724;16872.57818554546;16964.151792410084;16978.915105424392;14933.17867517297;14995.100293982396;15075.698486029998;15131;15180.01329913552;13305.268210248141;13342.332883355599;13370.665733356744;13438.865611343761;13497.055206135476;14155.716885662023;14305.713885722436;14325.21211333345;14423;14589.05171163871;10139;10173.643922462677;10338;10353.792924141324;10366.844497332697;10951.34291942486;11095.500702468247;11155.776884462428;11300.09599232043;11427.885721142682 11:45:59 INFO - PID 3805 | __end_tp_report 11:45:59 INFO - PID 3805 | __start_cc_report 11:45:59 INFO - PID 3805 | _x_x_mozilla_cycle_collect,291 11:45:59 INFO - PID 3805 | __end_cc_report 11:45:59 INFO - PID 3805 | __startTimestamp1506105959332__endTimestamp 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | ------- Summary: start ------- 11:45:59 INFO - PID 3805 | Number of tests: 6 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#0] dojo.html Cycles:165 Average:6304.67 Median:6562.38 stddev:779.73 (11.9%) stddev-sans-first:740.05 11:45:59 INFO - PID 3805 | Values: 3083.7 3109.4 3164.0 3171.0 3187.8 6389.5 6418.6 6447.3 6464.3 6492.5 6198.3 6295.9 6342.9 6494.5 6527.2 5872.3 5878.4 5971.9 5988.9 6058.3 5702.3 5726.2 5763.0 5847.8 5854.9 5809.4 5831.4 5834.7 5866.6 5901.8 5677.7 5746.6 5794.8 5807.1 5831.7 5773.7 5875.4 5897.6 5934.3 5936.1 6339.7 6363.7 6422.6 6431.8 6478.4 6677.0 6744.1 6819.6 6927.9 6934.9 6732.4 6815.5 6884.1 6886.3 6887.4 6379.1 6394.7 6449.0 6459.7 6466.8 6837.8 6900.4 6915.1 6938.3 7064.9 6609.4 6647.5 6653.7 6681.1 6700.8 6871.2 6884.4 6975.8 6982.1 6985.9 6752.9 6865.4 6946.9 6948.5 6961.7 6649.4 6909.6 6914.7 6999.4 7003.6 5337.6 5337.7 5339.7 5345.4 5379.5 4691.9 4711.1 4736.6 4748.4 4819.8 5884.7 5894.4 5949.9 5967.2 5980.4 6954.5 6968.5 7031.4 7040.0 7061.8 5679.9 5789.5 5793.3 5799.5 5926.3 5812.3 5841.4 5889.0 5894.5 5897.6 6618.3 6634.8 6756.3 6757.7 6759.7 6938.3 6941.7 7020.1 7029.1 7046.5 6389.9 6483.1 6615.8 6655.7 6742.6 6704.8 6751.0 6760.3 6774.6 6776.9 6879.3 6908.6 7035.3 7055.5 7056.9 6670.5 6672.0 6682.6 6762.9 6767.4 6451.6 6562.4 6682.9 6783.6 6784.6 6519.6 6603.0 6603.9 6605.8 6606.0 6747.4 6761.4 6802.7 6837.6 6860.3 6523.3 6525.6 6532.2 6621.2 6638.9 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#1] ext.html Cycles:180 Average:37024.06 Median:35188.56 stddev:53335.22 (151.6%) stddev-sans-first:53415.70 11:45:59 INFO - PID 3805 | Values: 855.5 880.3 904.9 906.6 907.4 39138.0 39938.6 39943.2 39949.6 39965.6 37417.4 39508.4 40047.6 40133.4 40134.4 7902.6 8002.1 8039.6 8062.8 8065.2 7889.5 8003.6 8011.7 8015.9 8030.9 8060.3 8061.8 8078.2 8117.3 8121.4 8020.2 8042.6 8060.0 8064.5 8080.0 7879.5 7902.5 7916.4 7930.2 7971.5 38177.2 38264.4 38286.8 38458.0 38543.2 3543.0 3581.0 3582.7 3590.9 3601.1 31141.5 31318.5 31396.7 31469.2 31477.7 4980.7 5122.4 5174.9 5201.4 5221.7 190802.0 193494.0 193874.0 195179.0 195433.0 47944.8 48396.8 48477.0 48626.3 48923.0 49994.3 50007.0 50143.7 50169.0 50386.5 14315.6 14447.9 14471.1 14475.9 14524.1 11470.1 11546.9 11563.9 11567.1 11586.1 13032.1 13079.7 13090.1 13193.1 13297.3 5322.6 5433.2 5437.8 5447.4 5495.0 1003.2 1016.9 1024.2 1035.9 1037.2 22465.7 22505.0 22695.4 22901.1 23282.2 1107.2 1110.9 1113.4 1123.6 1136.5 11986.0 12200.5 12234.6 12263.6 12269.8 226284.0 227461.0 228371.0 229276.0 229341.0 50724.0 50760.5 51049.7 51169.7 51218.5 1455.5 1459.2 1482.9 1488.4 1497.4 22316.3 22391.8 22683.9 22863.5 22900.8 36056.5 36173.3 36184.3 36251.5 36257.6 193388.0 193509.0 194000.0 194163.0 194227.0 29900.7 30499.5 33562.3 33663.3 33743.0 41075.6 41906.6 42191.6 42406.6 42996.0 30592.2 31015.4 31805.4 31931.5 32295.4 30710.5 31192.5 31285.0 31562.5 31705.8 35186.6 35190.5 35402.3 35511.5 35646.6 30852.2 31016.8 31254.8 31303.8 31378.0 22304.6 23096.4 23329.3 23336.2 23820.8 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#2] jquery.html Cycles:180 Average:33231.69 Median:22476.89 stddev:78404.82 (348.8%) stddev-sans-first:78586.47 11:45:59 INFO - PID 3805 | Values: 590.3 592.3 594.5 609.6 614.2 21957.7 22725.9 22740.2 22766.2 22781.2 23454.4 24092.3 25452.0 25516.0 25567.7 6582.1 6635.0 6701.9 6735.3 6740.0 6459.3 6562.2 6638.4 6674.6 6748.2 6705.9 6737.5 6740.8 6743.2 6749.2 6393.4 6689.6 6702.6 6725.9 6737.8 6208.0 6211.0 6212.5 6230.8 6241.0 27345.9 27666.9 27676.7 27794.6 27875.0 2032.5 2039.1 2057.0 2060.1 2062.2 19605.0 19787.4 20209.6 20446.4 20528.2 2473.4 2478.0 2532.8 2536.6 2543.9 117319.0 121708.4 126513.0 131149.0 132006.3 14792.9 15051.9 15227.5 15357.2 15398.2 23129.5 23228.0 23231.4 23294.4 23383.2 10190.6 10311.7 10422.6 10458.8 10521.0 9442.2 9500.9 9513.4 9613.5 9753.1 9255.0 9295.8 9672.6 10038.2 10490.4 2724.2 2753.3 2837.5 2897.6 2957.9 948.5 967.0 967.5 975.2 981.9 18972.9 19163.6 19212.1 19299.0 19615.3 1016.2 1016.7 1020.9 1021.6 1035.2 10562.8 10587.6 10686.7 10725.2 11022.2 459334.0 460768.0 470566.0 471654.0 475501.0 105589.5 107461.5 108642.0 108780.0 109634.0 1171.4 1196.4 1196.6 1197.0 1200.9 16836.9 17070.7 17312.0 17388.7 17410.8 52862.0 53073.0 53420.7 53469.5 54468.0 64681.4 64713.4 65109.7 65616.3 65905.7 14144.4 14365.9 14452.3 14616.9 14620.6 22377.4 22390.8 22443.9 22509.9 22511.1 17442.7 17920.3 17928.9 18329.3 18336.4 15400.2 15723.8 15896.8 16597.3 16657.8 18328.8 18453.4 18768.8 18781.3 18854.9 14226.8 14260.1 14260.4 14300.6 14325.7 17766.7 17918.9 17920.3 17955.9 18133.7 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#3] mootools.html Cycles:180 Average:9436.10 Median:2752.42 stddev:6795.89 (246.9%) stddev-sans-first:6787.43 11:45:59 INFO - PID 3805 | Values: 1295.0 1333.3 1345.2 1353.9 1354.0 12825.6 13381.2 13447.2 15787.3 16239.1 15566.5 15910.3 15919.1 15938.3 15963.3 2825.2 2861.4 2905.7 2907.6 2918.9 2837.7 2872.7 2873.0 2874.5 2876.8 2630.8 2674.9 2679.4 2824.3 2886.7 2754.6 2772.7 2776.3 2780.1 2790.3 2703.9 2732.5 2752.3 2752.5 2755.6 15186.1 15583.2 15651.3 15712.0 15758.3 8193.6 8457.8 8460.6 8463.4 8473.5 5288.3 5399.9 5590.5 5591.2 5659.1 1872.6 1973.2 1975.2 1997.8 2004.1 27112.2 27170.8 27276.6 27286.7 27310.9 6822.5 7000.4 7040.9 7247.5 7267.2 17432.4 17472.9 17483.8 17544.0 17592.2 8556.9 8849.4 8854.3 8859.9 8870.5 6029.9 6753.1 7831.0 7870.9 7900.8 5081.9 5249.8 5266.0 5275.6 5324.9 1621.3 1658.0 1665.9 1681.5 1684.4 829.4 851.2 862.5 869.6 880.1 7034.3 7065.5 7067.7 7090.8 7099.2 718.0 726.4 733.0 734.1 737.8 4788.0 4900.6 5087.5 5269.1 5274.4 20738.0 21515.1 21889.8 22086.8 22159.6 20438.7 21211.9 21496.5 21527.7 21573.7 11536.8 11539.7 11690.5 11742.6 11796.9 7972.3 8086.0 8102.4 8224.3 8257.9 18631.6 18699.2 19076.0 19095.0 19216.6 19741.0 19862.2 19923.8 20471.5 20693.0 11174.0 11231.9 11329.3 11368.5 11373.1 14106.5 14317.7 14334.4 14336.4 14346.9 10908.3 10959.7 11125.4 11180.3 11418.7 11214.1 11310.4 11356.7 11600.2 11675.0 9601.6 9697.9 9722.1 9723.4 9726.8 7441.3 7478.0 7531.5 7552.0 7580.8 6913.3 6982.2 7035.1 7092.0 7218.6 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#4] prototype.html Cycles:180 Average:5587.87 Median:6288.61 stddev:1549.99 (24.6%) stddev-sans-first:1506.53 11:45:59 INFO - PID 3805 | Values: 498.3 505.8 519.9 534.7 548.5 6396.4 6416.3 6462.9 6480.9 6511.0 6238.6 6253.2 6296.2 6312.4 6348.7 5280.0 5280.1 5285.3 5295.8 5309.3 4931.6 5236.9 5328.1 5330.8 5360.8 5028.3 5043.9 5066.4 5072.6 5082.5 5071.1 5071.4 5077.1 5129.6 5133.8 4558.6 4593.3 4609.1 4610.1 4612.6 6246.3 6247.6 6283.5 6293.7 6323.6 5823.8 5845.9 5868.8 5877.0 5886.9 6513.2 6597.5 6635.8 6677.5 6706.2 4941.9 4949.3 4962.7 4982.8 4985.1 6607.8 6797.3 6904.3 6929.2 7001.9 5074.3 5076.9 5099.3 5111.9 5142.3 5132.6 5165.2 5185.4 5192.9 5194.9 5692.1 5775.9 5788.8 5796.3 5820.7 6674.7 6709.7 6724.9 6725.2 6781.4 1761.3 1777.6 1786.1 1786.6 1803.2 1156.4 1229.4 1243.2 1257.3 1267.5 5646.2 5657.7 5685.9 5761.5 5765.3 6663.4 6676.4 6747.3 6766.8 6827.8 5690.5 5701.1 5708.3 5716.3 5736.3 3570.6 3575.2 3603.9 3632.9 3634.4 6217.3 6408.5 6434.9 6466.0 6501.9 6775.0 6822.4 6893.9 6902.5 6943.4 6342.2 6437.7 6445.6 6481.6 6522.1 6755.1 6794.5 6810.6 6844.3 6901.7 6760.9 6764.8 6781.5 6801.7 6815.5 6471.6 6528.2 6533.5 6579.3 6586.7 5064.3 5084.9 5090.5 5136.2 5150.8 6500.2 6676.4 6719.6 6733.4 6734.2 6458.3 6511.4 6603.2 6619.3 6680.2 6457.9 6549.8 6554.3 6578.9 6584.5 6459.3 6541.1 6552.0 6568.4 6580.9 6667.7 6679.9 6712.1 6733.4 6817.3 6417.6 6467.2 6475.1 6505.9 6510.6 11:45:59 INFO - PID 3805 | 11:45:59 INFO - PID 3805 | [#5] yui.html Cycles:180 Average:23935.32 Median:19673.06 stddev:35377.49 (179.8%) stddev-sans-first:35434.44 11:45:59 INFO - PID 3805 | Values: 896.9 919.1 928.0 934.4 948.1 19044.1 20101.8 20121.8 20158.8 20201.3 17993.6 18138.9 18481.0 18847.2 18977.3 954.7 973.9 977.4 977.5 977.8 965.8 970.5 978.3 980.5 1003.2 1065.0 1067.1 1067.4 1067.7 1068.4 1003.8 1045.9 1047.9 1051.6 1051.7 755.9 760.7 762.9 763.0 763.6 19660.3 19685.8 19781.9 19825.2 19833.6 21310.6 21317.9 22092.2 22304.1 22328.6 17298.9 17586.9 17654.4 17661.8 17803.6 3491.2 3528.5 3535.6 3539.2 3539.8 140128.3 140286.0 142304.0 145303.3 145521.0 16871.3 17051.1 17126.7 17204.9 17234.5 31143.8 31642.7 32117.4 32189.4 32493.8 8446.5 8500.8 8501.3 8538.2 8545.1 4337.2 4400.4 4463.1 4503.1 4521.0 5639.2 5739.4 5750.6 5776.4 5783.5 990.8 997.3 1015.2 1020.4 1022.8 647.8 649.8 660.7 663.3 679.0 10615.3 10711.4 10735.2 11173.4 11731.1 685.7 688.5 692.5 699.3 706.4 5408.6 5416.8 5486.5 5512.5 5570.7 121296.0 127483.0 128195.4 128845.0 130208.0 103869.0 105096.0 106271.0 106948.0 108224.5 86247.6 86264.6 87537.0 87556.0 88099.6 10035.4 10063.3 10071.2 10121.8 10228.3 43350.0 43409.6 43780.3 44326.8 44449.3 53842.2 55288.0 56697.0 56973.0 57618.1 13767.4 13876.2 13941.2 14114.6 14133.9 16456.7 16667.7 16872.6 16964.2 16978.9 14933.2 14995.1 15075.7 15131.0 15180.0 13305.3 13342.3 13370.7 13438.9 13497.1 14155.7 14305.7 14325.2 14423.0 14589.1 10139.0 10173.6 10338.0 10353.8 10366.8 10951.3 11095.5 11155.8 11300.1 11427.9 11:45:59 INFO - PID 3805 | -------- Summary: end -------- 11:45:59 INFO - PID 3805 | 11:46:00 INFO - TEST-INFO | 3805: exit 0 11:46:00 INFO - TEST-OK | dromaeo_css | took 1108611ms 11:46:00 INFO - TEST-START | kraken 11:46:00 INFO - Initialising browser for kraken test... 11:46:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58686/getInfo.html -profile /tmp/tmpueStzE/profile 11:46:00 INFO - TEST-INFO | started process 4170 (/builds/slave/test/build/application/firefox/firefox http://localhost:58686/getInfo.html) 11:46:04 INFO - TEST-INFO | 4170: exit 0 11:46:04 INFO - Browser initialized. 11:46:04 INFO - Running cycle 1/1 for kraken test... 11:46:04 INFO - Using env: {'DISPLAY': ':0', 11:46:04 INFO - 'HOME': '/home/cltbld', 11:46:04 INFO - 'JSGC_DISABLE_POISONING': '1', 11:46:04 INFO - 'LANG': 'en_US.UTF-8', 11:46:04 INFO - 'LANGUAGE': 'en_US:en', 11:46:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:46:04 INFO - 'LOGNAME': 'cltbld', 11:46:04 INFO - 'MAIL': '/var/mail/cltbld', 11:46:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:46:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:46:04 INFO - 'MOZ_CRASHREPORTER': '1', 11:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:46:04 INFO - 'MOZ_NO_REMOTE': '1', 11:46:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:04 INFO - 'NO_EM_RESTART': '1', 11:46:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:04 INFO - 'PWD': '/builds/slave/test', 11:46:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:46:04 INFO - 'RUST_BACKTRACE': 'full', 11:46:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:46:04 INFO - 'SHELL': '/bin/bash', 11:46:04 INFO - 'SHLVL': '1', 11:46:04 INFO - 'STYLO_FORCE_DISABLED': '1', 11:46:04 INFO - 'TERM': 'linux', 11:46:04 INFO - 'TMOUT': '86400', 11:46:04 INFO - 'USER': 'cltbld', 11:46:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1506101691.561142-505122057', 11:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:04 INFO - '_': '/tools/buildbot/bin/python'} 11:46:04 INFO - TEST-INFO | started process 4400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpueStzE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:05 INFO - PID 4400 | 11:46:05 INFO - PID 4400 | (/builds/slave/test/build/application/firefox/firefox:4449): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:46:05 INFO - PID 4400 | 11:46:16 INFO - PID 4400 | RSS: Main: 153731072 11:46:16 INFO - PID 4400 | 11:46:18 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58686/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:19 INFO - PID 4400 | RSS: Main: 160387072 11:46:19 INFO - PID 4400 | 11:46:22 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58686/tests/kraken/driver.html?testName=audio-dft) 11:46:22 INFO - PID 4400 | RSS: Main: 160956416 11:46:22 INFO - PID 4400 | 11:46:25 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58686/tests/kraken/driver.html?testName=audio-fft) 11:46:26 INFO - PID 4400 | RSS: Main: 156368896 11:46:26 INFO - PID 4400 | 11:46:28 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58686/tests/kraken/driver.html?testName=audio-oscillator) 11:46:29 INFO - PID 4400 | RSS: Main: 156868608 11:46:29 INFO - PID 4400 | 11:46:31 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:31 INFO - PID 4400 | RSS: Main: 156868608 11:46:31 INFO - PID 4400 | 11:46:35 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58686/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:35 INFO - PID 4400 | RSS: Main: 159100928 11:46:35 INFO - PID 4400 | 11:46:39 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58686/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:40 INFO - PID 4400 | RSS: Main: 159838208 11:46:40 INFO - PID 4400 | 11:46:43 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58686/tests/kraken/driver.html?testName=json-parse-financial) 11:46:43 INFO - PID 4400 | RSS: Main: 159768576 11:46:43 INFO - PID 4400 | 11:46:45 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:45 INFO - PID 4400 | RSS: Main: 159649792 11:46:45 INFO - PID 4400 | 11:46:47 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:48 INFO - PID 4400 | RSS: Main: 159567872 11:46:48 INFO - PID 4400 | 11:46:50 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:50 INFO - PID 4400 | RSS: Main: 156504064 11:46:50 INFO - PID 4400 | 11:46:53 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:54 INFO - PID 4400 | RSS: Main: 156794880 11:46:54 INFO - PID 4400 | 11:46:57 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:57 INFO - PID 4400 | RSS: Main: 157179904 11:46:57 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:58686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58686/tests/kraken/driver.html?testName=ai-astar) 11:46:59 INFO - PID 4400 | RSS: Main: 158367744 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | __start_tp_report 11:46:59 INFO - PID 4400 | _x_x_mozilla_page_load 11:46:59 INFO - PID 4400 | _x_x_mozilla_page_load_details 11:46:59 INFO - PID 4400 | |i|pagename|runs| 11:46:59 INFO - PID 4400 | |0;ai-astar;107;106;106;106;106;110;106;106;106;107 11:46:59 INFO - PID 4400 | |1;audio-beat-detection;120;121;119;116;120;122;124;117;118;118 11:46:59 INFO - PID 4400 | |2;audio-dft;164;162;162;162;164;162;162;164;165;166 11:46:59 INFO - PID 4400 | |3;audio-fft;74;74;75;73;75;73;76;73;74;73 11:46:59 INFO - PID 4400 | |4;audio-oscillator;80;79;79;78;78;79;80;80;79;79 11:46:59 INFO - PID 4400 | |5;imaging-gaussian-blur;118;115;117;114;114;110;114;114;114;115 11:46:59 INFO - PID 4400 | |6;imaging-darkroom;150;147;146;148;148;150;148;148;150;150 11:46:59 INFO - PID 4400 | |7;imaging-desaturate;95;94;94;95;95;95;94;94;95;94 11:46:59 INFO - PID 4400 | |8;json-parse-financial;57;55;56;53;53;55;54;53;53;54 11:46:59 INFO - PID 4400 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;38;39;38 11:46:59 INFO - PID 4400 | |10;stanford-crypto-aes;77;73;73;73;72;73;74;74;74;79 11:46:59 INFO - PID 4400 | |11;stanford-crypto-ccm;113;119;109;120;118;119;112;115;110;115 11:46:59 INFO - PID 4400 | |12;stanford-crypto-pbkdf2;169;166;172;179;179;167;168;176;171;169 11:46:59 INFO - PID 4400 | |13;stanford-crypto-sha256-iterative;67;69;63;64;67;65;66;82;68;62 11:46:59 INFO - PID 4400 | __end_tp_report 11:46:59 INFO - PID 4400 | __start_cc_report 11:46:59 INFO - PID 4400 | _x_x_mozilla_cycle_collect,747 11:46:59 INFO - PID 4400 | __end_cc_report 11:46:59 INFO - PID 4400 | __startTimestamp1506106019678__endTimestamp 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | ------- Summary: start ------- 11:46:59 INFO - PID 4400 | Number of tests: 14 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#0] ai-astar Cycles:10 Average:106.60 Median:106.00 stddev:1.26 (1.2%) stddev-sans-first:1.33 11:46:59 INFO - PID 4400 | Values: 107.0 106.0 106.0 106.0 106.0 110.0 106.0 106.0 106.0 107.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:120.00 stddev:2.42 (2.0%) stddev-sans-first:2.55 11:46:59 INFO - PID 4400 | Values: 120.0 121.0 119.0 116.0 120.0 122.0 124.0 117.0 118.0 118.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 11:46:59 INFO - PID 4400 | Values: 164.0 162.0 162.0 162.0 164.0 162.0 162.0 164.0 165.0 166.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:1.05 (1.4%) stddev-sans-first:1.12 11:46:59 INFO - PID 4400 | Values: 74.0 74.0 75.0 73.0 75.0 73.0 76.0 73.0 74.0 73.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 11:46:59 INFO - PID 4400 | Values: 80.0 79.0 79.0 78.0 78.0 79.0 80.0 80.0 79.0 79.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:2.12 (1.9%) stddev-sans-first:1.83 11:46:59 INFO - PID 4400 | Values: 118.0 115.0 117.0 114.0 114.0 110.0 114.0 114.0 114.0 115.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.43 (1.0%) stddev-sans-first:1.41 11:46:59 INFO - PID 4400 | Values: 150.0 147.0 146.0 148.0 148.0 150.0 148.0 148.0 150.0 150.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:46:59 INFO - PID 4400 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.42 (2.6%) stddev-sans-first:1.12 11:46:59 INFO - PID 4400 | Values: 57.0 55.0 56.0 53.0 53.0 55.0 54.0 53.0 53.0 54.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 11:46:59 INFO - PID 4400 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.15 (2.9%) stddev-sans-first:2.03 11:46:59 INFO - PID 4400 | Values: 77.0 73.0 73.0 73.0 72.0 73.0 74.0 74.0 74.0 79.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:116.50 stddev:3.94 (3.4%) stddev-sans-first:4.12 11:46:59 INFO - PID 4400 | Values: 113.0 119.0 109.0 120.0 118.0 119.0 112.0 115.0 110.0 115.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:4.81 (2.8%) stddev-sans-first:5.01 11:46:59 INFO - PID 4400 | Values: 169.0 166.0 172.0 179.0 179.0 167.0 168.0 176.0 171.0 169.0 11:46:59 INFO - PID 4400 | 11:46:59 INFO - PID 4400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:5.62 (8.4%) stddev-sans-first:5.96 11:46:59 INFO - PID 4400 | Values: 67.0 69.0 63.0 64.0 67.0 65.0 66.0 82.0 68.0 62.0 11:46:59 INFO - PID 4400 | -------- Summary: end -------- 11:46:59 INFO - PID 4400 | 11:47:00 INFO - PID 4400 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:47:00 INFO - TEST-INFO | 4400: exit 0 11:47:00 INFO - TEST-OK | kraken | took 60284ms 11:47:00 INFO - SUITE-END | took 1168s 11:47:00 INFO - Completed test suite (00:19:28) 11:47:00 INFO - javascript benchmark 11:47:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8500.084220799356, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.722464978152, 3109.3781243751255, 3164.019154062241, 3171.0328349853294, 3187.792793468423, 6389.520785941049, 6418.614883107005, 6447.258565264996, 6464.3212462691445, 6492.480601551876, 6198.318184999646, 6295.937040629592, 6342.904856427146, 6494.480441564675, 6527.151470308853, 5872.265966754156, 5878.441548052928, 5971.880562388749, 5988.880222395549, 6058.3032951210735, 5702.344230413493, 5726.169705392736, 5763.0, 5847.766089356442, 5854.88290234195, 5809.419058094199, 5831.446012628793, 5834.708264586754, 5866.560007999417, 5901.793437229698, 5677.659340439545, 5746.626469279484, 5794.768209271666, 5807.070868660994, 5831.737571809279, 5773.740181691834, 5875.383084776123, 5897.6166549174595, 5934.258217722785, 5936.050231962865, 6339.651319177444, 6363.7454501819875, 6422.646754428504, 6431.807045788634, 6478.384553467413, 6677.0, 6744.123263975701, 6819.556728812611, 6927.930720692779, 6934.861302773967, 6732.427743641796, 6815.454763618898, 6884.1050663413935, 6886.345797149263, 6887.449004079662, 6379.106925030499, 6394.712237949257, 6448.967755161194, 6459.709313080923, 6466.80599582018, 6837.760678376233, 6900.413464855544, 6915.101036865175, 6938.340857618518, 7064.92935070653, 6609.372109649576, 6647.501437392215, 6653.73385064592, 6681.09805176295, 6700.798976030727, 6871.209810871714, 6884.449244060464, 6975.79072627822, 6982.092327997328, 6985.89521157183, 6752.93247067523, 6865.41643960259, 6946.930530694628, 6948.513604047769, 6961.65191740411, 6649.368310010638, 6909.550879192836, 6914.688839002257, 6999.370056694922, 7003.614801185881, 5337.599680024014, 5337.733113344318, 5339.733013349317, 5345.3852806926925, 5379.462053794668, 4691.859244222679, 4711.104890070876, 4736.5973892219545, 4748.430188377348, 4819.759012049383, 5884.676342801102, 5894.351621321651, 5949.940500594938, 5967.224260846062, 5980.43185897339, 6954.513184077066, 6968.512204145763, 7031.437485001187, 7039.964800175966, 7061.752838650623, 5679.8864022720145, 5789.45000224978, 5793.275840519935, 5799.507041901401, 5926.348101708809, 5812.331581868055, 5841.357450680422, 5888.970555147197, 5894.528437724972, 5897.616654917502, 6618.271990081087, 6634.800955971328, 6756.2568117507035, 6757.662116894136, 6759.662016899136, 6938.306169383021, 6941.687624057031, 7020.05229294049, 7029.05107810439, 7046.5419747715205, 6389.87220255583, 6483.092367068709, 6615.801525954229, 6655.73377064912, 6742.561733487308, 6704.765333213314, 6750.966245168743, 6760.290169532128, 6774.559653622498, 6776.898346524905, 6879.346462086094, 6908.585484870924, 7035.261297563682, 7055.506114571931, 7056.929430705627, 6670.533062685566, 6672.03255527936, 6682.63245521501, 6762.932370676427, 6767.35710107539, 6451.580647258101, 6562.376574225441, 6682.866342673216, 6783.626900520519, 6784.626845523544, 6519.6088234704175, 6603.0, 6603.933960660332, 6605.834854128493, 6606.042123892104, 6747.359000894907, 6761.425278851353, 6802.727890884309, 6837.555558888656, 6860.3139686031, 6523.3476652336285, 6525.575837570543, 6532.248791389051, 6621.172353455818, 6638.867222655616], "value": 6243.249800683299, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.4653341661461, 880.2517859819154, 904.8868891388574, 906.5829718329568, 907.4464576608268, 39138.0, 39938.600613993854, 39943.201135977266, 39949.60050399495, 39965.60034399651, 37417.43873841895, 39508.407373889415, 40047.59952400475, 40133.397999030036, 40134.39798403019, 7902.604869756504, 8002.119766825645, 8039.55782431966, 8062.838743225132, 8065.233802788725, 7889.487183333065, 8003.559804210766, 8011.67953281868, 8015.879761803578, 8030.879536806952, 8060.274575288223, 8061.838763224732, 8078.151794061627, 8117.269445749881, 8121.431499795017, 8020.157883422245, 8042.638081286356, 8060.0, 8064.516129032248, 8080.0, 7879.527228366259, 7902.4863383879865, 7916.406269529808, 7930.246626570467, 7971.521708697497, 38177.23645527074, 38264.42603360952, 38286.80856595727, 38458.0, 38543.22913541713, 3543.0, 3581.0, 3582.659647333499, 3590.9461358079648, 3601.099725068733, 31141.532877006863, 31318.530222046687, 31396.686033139606, 31469.213269668213, 31477.685223147935, 4980.651354405193, 5122.359705036871, 5174.948250517485, 5201.427842937273, 5221.71280579568, 190802.0, 193494.0, 193874.0, 195179.02410488, 195433.0, 47944.760276198394, 48396.7580162104, 48477.0, 48626.27060594094, 48923.02153956901, 49994.250086248736, 50007.0, 50143.74928125336, 50169.0, 50386.49613503818, 14315.57053288403, 14447.85552144486, 14471.059381140403, 14475.855241447662, 14524.128552286897, 11470.082393408507, 11546.884531154581, 11563.88436115645, 11567.132465065153, 11586.073114150848, 13032.087753857139, 13079.673008174681, 13090.08369414151, 13193.076484645982, 13297.3351332433, 5322.627416080837, 5433.239346491494, 5437.8368648940595, 5447.400785913546, 5495.0, 1003.2225025605214, 1016.9186465082776, 1024.1704219582161, 1035.8705161854768, 1037.234837539726, 22465.663015054786, 22505.0, 22695.432614184447, 22901.08395664155, 23282.185123520594, 1107.1530279336314, 1110.8613670987302, 1113.3820729495046, 1123.584273818676, 1136.4885801389407, 11986.0, 12200.511979520898, 12234.632961011184, 12263.570775022832, 12269.815952760715, 226284.0, 227461.0, 228371.0, 229276.0, 229341.0, 50724.0, 50760.49239507558, 51049.744751276005, 51169.74415127975, 51218.48781512137, 1455.5487798782624, 1459.1755658053378, 1482.8739557137549, 1488.3823213366331, 1497.3561368611602, 22316.330510084725, 22391.77608223962, 22683.886580566992, 22863.542729145658, 22900.770992289865, 36056.4591531122, 36173.27653446969, 36184.27631447409, 36251.45622815713, 36257.63742362543, 193388.0, 193509.0, 194000.0, 194163.0, 194227.0, 29900.70099298979, 30499.54250686197, 33562.32875342528, 33663.326733465685, 33743.0, 41075.58924410837, 41906.58093419149, 42191.57808421999, 42406.57593424026, 42996.0, 30592.235194120323, 31015.379692406477, 31805.36389272248, 31931.521027185074, 32295.35409291848, 30710.539341910335, 31192.53211201879, 31285.0, 31562.526562101128, 31705.841470792497, 35186.648133518334, 35190.47214291839, 35402.29195416026, 35511.46732799062, 35646.64353356433, 30852.22869428282, 31016.844915775277, 31254.843725781226, 31303.84348078245, 31378.0, 22304.553908922055, 23096.4225894354, 23329.3001209964, 23336.183233586744, 23820.761792381854], "value": 16930.42444592285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.347665829259, 592.2862950145076, 594.506559555569, 609.5763444406139, 614.2444792904727, 21957.67063494047, 22725.886370568165, 22740.204092856755, 22766.203182888603, 22781.202657906975, 23454.41363965902, 24092.277231683078, 25452.0, 25516.0, 25567.74432255677, 6582.111414958991, 6635.037919501669, 6701.932980670204, 6735.32646735325, 6739.966300168492, 6459.289478157399, 6562.212534495843, 6638.369354911276, 6674.599524028549, 6748.190217173946, 6705.865882682343, 6737.528373013891, 6740.797776066702, 6743.15710536183, 6749.223839258474, 6393.392627700361, 6689.632070236135, 6702.631355275458, 6725.932740672604, 6737.831554211135, 6208.006718924996, 6211.0, 6212.502999760009, 6230.813075607739, 6240.968795156041, 27345.86327068372, 27666.861665691744, 27676.723232767617, 27794.583081253797, 27875.0, 2032.5121970727066, 2039.1333683184587, 2057.022914115783, 2060.124447109972, 2062.226665000625, 19605.0, 19787.40637780869, 20209.595808083905, 20446.38660840177, 20528.178872845067, 2473.3692908308444, 2478.021181633245, 2532.8353657012235, 2536.6195070739354, 2543.9491210175693, 117319.0, 121708.39145804214, 126513.0, 131149.0, 132006.3399683005, 14792.928989941416, 15051.93597728629, 15227.467038653594, 15357.155356455502, 15398.229203641724, 23129.537409252058, 23228.0, 23231.419214519774, 23294.417639559146, 23383.181588644657, 10190.592376304865, 10311.690649280534, 10422.583096676048, 10458.790824183474, 10521.0, 9442.244620430349, 9500.8623059811, 9513.381630194015, 9613.471259080678, 9753.122219000183, 9254.953725231466, 9295.76760580991, 9672.613095476243, 10038.19694424459, 10490.370577765358, 2724.223596275052, 2753.3231912611836, 2837.4608824323313, 2897.6377952755906, 2957.8816847325866, 948.5020364308655, 966.990330096704, 967.5307475874196, 975.1857199238574, 981.8625392445064, 18972.905135474233, 19163.61672766537, 19212.135453904328, 19299.0, 19615.313464028975, 1016.2428990402198, 1016.6645007147623, 1020.9234307426824, 1021.6066814276558, 1035.2442716816765, 10562.841557376645, 10587.57649694019, 10686.679399618024, 10725.195610329101, 11022.173336999756, 459334.0, 460768.0, 470566.0, 471654.0, 475501.0, 105589.47205263925, 107461.46269268604, 108642.0, 108780.0, 109634.0, 1171.4142928535732, 1196.407778149804, 1196.6410076976872, 1196.9880301197052, 1200.855897292313, 16836.915815421333, 17070.658586828442, 17312.047837368562, 17388.739168912223, 17410.825891740922, 52862.0, 53073.0, 53420.73289633527, 53469.46530534645, 54468.0, 64681.35318646753, 64713.35286647262, 65109.67445162744, 65616.34383656293, 65905.67047164733, 14144.43422263098, 14365.92817035908, 14452.277386130441, 14616.926915365355, 14620.634484137981, 22377.44056398603, 22390.77609223887, 22443.88778056099, 22509.88745056264, 22511.09955601823, 17442.651146976736, 17920.283188672307, 17928.91035544866, 18329.266829326676, 18336.358227461973, 15400.152991585122, 15723.764143537628, 15896.761548577011, 16597.336106555602, 16657.750133748246, 18328.81671183271, 18453.446396608124, 18768.812311876707, 18781.34265300708, 18854.905725471286, 14226.786598200828, 14260.144391336553, 14260.358283877044, 14300.570982870531, 14325.713485730435, 17766.733498997266, 17918.91040544789, 17920.283188672307, 17955.910220448815, 18133.727994080364], "value": 11869.79261311214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.9676258093546, 1333.293354522103, 1345.2466618693531, 1353.8578449262834, 1354.018336705889, 12825.615231543057, 13381.197128172304, 13447.19316840989, 15787.28957196926, 16239.106849123293, 15566.533004009869, 15910.284037218324, 15919.124448155348, 15938.28277727502, 15963.281652325644, 2825.152454263723, 2861.399106187703, 2905.680375158731, 2907.592936988823, 2918.8540572971374, 2837.7020412856664, 2872.6840047594746, 2872.956905646417, 2874.4538537677877, 2876.7698584113327, 2630.842149471038, 2674.933126671829, 2679.4105296834664, 2824.265690920365, 2886.7113288671176, 2754.5868119781994, 2772.6811416686937, 2776.250412388654, 2780.138157171273, 2790.344269096761, 2703.9188824335106, 2732.49448851963, 2752.3394385347574, 2752.4907892039837, 2755.641766570353, 15186.088834669956, 15583.220838958006, 15651.295691693902, 15712.0, 15758.290876910567, 8193.590320483952, 8457.788555286106, 8460.619272132768, 8463.4075614707, 8473.49159050459, 5288.260479936259, 5399.946000539983, 5590.496855283044, 5591.245181900432, 5659.066254068074, 1872.6161136967025, 1973.15154483572, 1975.1803001754254, 1997.7602687677572, 2004.0781240629328, 27112.186634400998, 27170.777315020674, 27276.590851137247, 27286.727132728814, 27310.863445682844, 6822.522423430312, 7000.404965577881, 7040.859182816417, 7247.528910620793, 7267.236940121317, 17432.38986635487, 17472.912635436995, 17483.825161748475, 17544.0, 17592.208350624252, 8556.871646925301, 8849.4247873888, 8854.29165666745, 8859.936807583132, 8870.467771933576, 6029.879402411927, 6753.1220941277315, 7830.960845195737, 7870.881936770953, 7900.841983160304, 5081.923771143436, 5249.790008399697, 5266.0, 5275.57795376369, 5324.946750532523, 1621.3190460006826, 1658.0, 1665.875059370552, 1681.4955513345947, 1684.351524662989, 829.4111181061394, 851.1956201389751, 862.4523427623504, 869.573908784691, 880.0891077734514, 7034.331738484836, 7065.540739851893, 7067.71729130829, 7090.751823686146, 7099.183593886666, 717.9784606461815, 726.4224941171781, 732.9780106596811, 734.1263895963785, 737.789729926979, 4787.952120478751, 4900.558949694545, 5087.465816089331, 5269.104252277122, 5274.4198138204765, 20738.0, 21515.13939442436, 21889.781102188776, 22086.779132208794, 22159.556808863734, 20438.69341959872, 21211.893940530506, 21496.462588435414, 21527.67708484374, 21573.67639485409, 11536.808006478743, 11539.653810385535, 11690.532378704927, 11742.647720568397, 11796.882031179579, 7972.322352599862, 8085.9595702021115, 8102.3899959678065, 8224.342052635895, 8257.917420825715, 18631.627367452846, 18699.195120731998, 19076.0, 19095.0, 19216.61566768685, 19741.0, 19862.205511779946, 19923.800761992195, 20471.4882127948, 20693.0, 11174.0, 11231.887681123084, 11329.263597866113, 11368.54525818958, 11373.090152787592, 14106.506272280421, 14317.713645726819, 14334.426622934965, 14336.354864030935, 14346.928265358607, 10908.34549927007, 10959.726006849893, 11125.44372781374, 11180.329180249211, 11418.657440276806, 11214.102871770401, 11310.434478276218, 11356.659300221007, 11600.245984011011, 11675.0, 9601.567929443332, 9697.854532182164, 9722.076402741728, 9723.416595004323, 9726.756831078996, 7441.255874412515, 7477.969281743625, 7531.472796904164, 7551.962240188984, 7580.810479738051, 6913.308669133247, 6982.197047339621, 7035.050268213726, 7092.04257425241, 7218.566885986857], "value": 6700.9848630713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.34716521357024, 505.8264825604599, 519.8648351428627, 534.6845361236869, 548.4926443040188, 6396.392342727445, 6416.3262857400005, 6462.870742585145, 6480.902786458207, 6511.0, 6238.563300568962, 6253.24961004679, 6296.244450665915, 6312.431881130698, 6348.650824204667, 5279.99999999999, 5280.128778751501, 5285.339332583427, 5295.841124766263, 5309.33633295838, 4931.556159945604, 5236.895262094756, 5328.1474964005765, 5330.813421530247, 5360.839174824742, 5028.2709007193935, 5043.949560504385, 5066.442691303953, 5072.594192464594, 5082.467684958955, 5071.112555302807, 5071.366079240095, 5077.136886729265, 5129.589632829365, 5133.845984620468, 4558.635309175258, 4593.333966574828, 4609.101225261075, 4610.077984403133, 4612.607928326096, 6246.281677607088, 6247.62514249142, 6283.465905398047, 6293.748250069992, 6323.557350985433, 5823.845177284389, 5845.883082338372, 5868.76524939002, 5877.032098790126, 5886.8822623547285, 6513.153290072308, 6597.538172327939, 6635.834104147387, 6677.465802735769, 6706.161729783777, 4941.901161976741, 4949.307097006422, 4962.660081777936, 4982.825601103944, 4985.077760614262, 6607.768728094542, 6797.286284940109, 6904.273931517121, 6929.203141638675, 7001.929980700179, 5074.264231686385, 5076.898462030738, 5099.337086178847, 5111.897762044812, 5142.331496905454, 5132.563732082815, 5165.199394093921, 5185.429602743695, 5192.948070519246, 5194.870128246824, 5692.117721753135, 5775.913361299584, 5788.797392091256, 5796.333421656479, 5820.708964551755, 6674.699638516278, 6709.6980635871505, 6724.9327506725285, 6725.192976842713, 6781.355771201728, 1761.3218910719208, 1777.5911540345792, 1786.0801687131138, 1786.642671465712, 1803.1885651456896, 1156.3986726902133, 1229.434460148324, 1243.154654834721, 1257.2896313582796, 1267.518343029643, 5646.193218170146, 5657.717114144276, 5685.9480996015045, 5761.452661997104, 5765.279340082489, 6663.433608143265, 6676.365745254193, 6747.257801641816, 6766.763163289262, 6827.780971184385, 5690.459406356389, 5701.144828275792, 5708.257926469532, 5716.314042314865, 5736.311642602915, 3570.625084366156, 3575.2313252650806, 3603.94594081089, 3632.8728494502566, 3634.400323946572, 6217.316095229521, 6408.455281301141, 6434.935650643433, 6466.0, 6501.934980650228, 6775.017622444718, 6822.420094292041, 6893.93106068943, 6902.516823822284, 6943.409810166091, 6342.2072240968955, 6437.67811609427, 6445.581037232565, 6481.643509606923, 6522.119513865568, 6755.1423358576785, 6794.456443484608, 6810.557313774589, 6844.315568443116, 6901.654917254217, 6760.93239067603, 6764.797056088325, 6781.457483401415, 6801.659917004229, 6815.522913396015, 6471.611703297817, 6528.183977002875, 6533.477321814338, 6579.276279609335, 6586.703598338182, 5064.316317297265, 5084.8897707451, 5090.490950905028, 5136.229565565195, 5150.768215430239, 6500.187476565429, 6676.432503237279, 6719.563228390334, 6733.3939945405145, 6734.191896972395, 6458.257300410325, 6511.37215696076, 6603.20761508622, 6619.304972977768, 6680.164979377578, 6457.903131452938, 6549.803505894831, 6554.311797261219, 6578.934210657832, 6584.473242140713, 6459.257185423737, 6541.08424820516, 6552.0, 6568.441682456853, 6580.868382632416, 6667.733290668319, 6679.8664026718225, 6712.127423434922, 6733.3939945405145, 6817.250102488623, 6417.550771446141, 6467.159269294962, 6475.125858009108, 6505.902411463927, 6510.576812507361], "value": 5130.349714496198, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.8789213456181, 919.0717375450795, 928.011667574034, 934.3833070173682, 948.0898337595908, 19044.14301356439, 20101.798982010176, 20121.798782012174, 20158.798412015876, 20201.292954746586, 17993.640127197446, 18138.909305453486, 18481.0, 18847.15187816548, 18977.33579324724, 954.6801821389843, 973.9123478886899, 977.4135518688801, 977.5454413697629, 977.8142152990908, 965.75856035991, 970.4565443351746, 978.3151793744372, 980.4607465893765, 1003.2425518733346, 1065.046783129099, 1067.0983019348637, 1067.4395942130366, 1067.7063807452935, 1068.4123731947436, 1003.7590978165188, 1045.900639439252, 1047.9056884880358, 1051.626672531248, 1051.6897515232986, 755.8866170074477, 760.6919197724931, 762.8931949527071, 762.9885551716728, 763.6296396247816, 19660.311889083958, 19685.80314196854, 19781.9010904946, 19825.206991720315, 19833.60332793336, 21310.573788524296, 21317.893410533004, 22092.226772062902, 22304.107835686555, 22328.55342893133, 17298.91350543252, 17586.91206543972, 17654.382096626683, 17661.823381766146, 17803.643927121386, 3491.2319289756215, 3528.5060091587197, 3535.5580552430947, 3539.2213712983103, 3539.752217344787, 140128.29935850357, 140286.0, 142304.0, 145303.2734836319, 145521.0, 16871.325146993982, 17051.147442628066, 17126.657466850593, 17204.91397543004, 17234.482965511055, 31143.844280778452, 31642.683573163973, 32117.35765284681, 32189.356212875613, 32493.837530812667, 8446.493210407396, 8500.787480312918, 8501.319894408556, 8538.231559159582, 8545.145485451405, 4337.240982827992, 4400.361947517592, 4463.062756821039, 4503.076869241798, 4521.0, 5639.238702775155, 5739.426057394227, 5750.597458177971, 5776.42235776419, 5783.508401785895, 990.8464188050864, 997.2769741937037, 1015.1777060580953, 1020.3622735790132, 1022.8465730140539, 647.7506160128385, 649.7953144759385, 660.7291010685692, 663.2704025571928, 678.966051697423, 10615.31000484966, 10711.410872401937, 10735.194860385502, 11173.441327933733, 11731.120165987584, 685.7120009595982, 688.5317983771084, 692.4806395203598, 699.3286445012844, 706.4101475268106, 5408.621396502207, 5416.8104116355735, 5486.506214440719, 5512.5314348280845, 5570.6657600543285, 121296.0, 127483.0, 128195.35902320615, 128845.0, 130208.0, 103869.0, 105096.0, 106271.0, 106948.0, 108224.45887770511, 86247.56876215579, 86264.56867715622, 87537.0, 87556.0, 88099.55950220207, 10035.448050357008, 10063.295569310078, 10071.244656650928, 10121.797564048826, 10228.312328466018, 43350.0, 43409.565904340554, 43780.34329484997, 44326.77836610797, 44449.333260001775, 53842.192367115305, 55288.0, 56697.0, 56973.0, 57618.13572796495, 13767.449302027806, 13876.236806975714, 13941.233232172328, 14114.576562703136, 14133.929330353283, 16456.67086658284, 16667.66664666724, 16872.57818554546, 16964.151792410084, 16978.915105424392, 14933.17867517297, 14995.100293982396, 15075.698486029998, 15131.0, 15180.01329913552, 13305.268210248141, 13342.332883355599, 13370.665733356744, 13438.865611343761, 13497.055206135476, 14155.716885662023, 14305.713885722436, 14325.21211333345, 14423.0, 14589.05171163871, 10139.0, 10173.643922462677, 10338.0, 10353.792924141324, 10366.844497332697, 10951.34291942486, 11095.500702468247, 11155.776884462428, 11300.09599232043, 11427.885721142682], "value": 8743.950846530204, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1420.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 106.0, 106.0, 110.0, 106.0, 106.0, 106.0, 107.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 119.0, 116.0, 120.0, 122.0, 124.0, 117.0, 118.0, 118.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 162.0, 164.0, 162.0, 162.0, 164.0, 165.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 73.0, 75.0, 73.0, 76.0, 73.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 78.0, 79.0, 80.0, 80.0, 79.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 117.0, 114.0, 114.0, 110.0, 114.0, 114.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 146.0, 148.0, 148.0, 150.0, 148.0, 148.0, 150.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 53.0, 53.0, 55.0, 54.0, 53.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 73.0, 72.0, 73.0, 74.0, 74.0, 74.0, 79.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 109.0, 120.0, 118.0, 119.0, 112.0, 115.0, 110.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 172.0, 179.0, 179.0, 167.0, 168.0, 176.0, 171.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 63.0, 64.0, 67.0, 65.0, 66.0, 82.0, 68.0, 62.0], "value": 67.3, "unit": "score"}]}]} 11:47:00 INFO - Return code: 0 11:47:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:47:00 INFO - # TBPL SUCCESS # 11:47:00 INFO - Running post-action listener: _package_coverage_data 11:47:00 INFO - Running post-action listener: _resource_record_post_action 11:47:00 INFO - [mozharness: 2017-09-22 18:47:00.445676Z] Finished run-tests step (success) 11:47:00 INFO - Running post-run listener: _resource_record_post_run 11:47:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 9113600; Write bytes: 455917568; Read time: 2672; Write time: 350300 11:47:00 INFO - TinderboxPrint: CPU usage
13.1% 11:47:00 INFO - TinderboxPrint: I/O read bytes / time
9,113,600 / 2,672 11:47:00 INFO - TinderboxPrint: I/O write bytes / time
455,917,568 / 350,300 11:47:00 INFO - TinderboxPrint: CPU idle
8,221.9 (86.9%) 11:47:00 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 11:47:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:47:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 136908800; Read time: 44; Write time: 133836 11:47:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:47:00 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 6606848; Write bytes: 319008768; Read time: 1968; Write time: 216464 11:47:01 INFO - Running post-run listener: _upload_blobber_files 11:47:01 INFO - Blob upload gear active. 11:47:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:47:01 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'] 11:47:01 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 11:47:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:02 INFO - (blobuploader) - INFO - Done attempting. 11:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:03 INFO - (blobuploader) - INFO - Done attempting. 11:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:04 INFO - (blobuploader) - INFO - Done attempting. 11:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:11 INFO - (blobuploader) - INFO - Done attempting. 11:47:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:11 INFO - Return code: 0 11:47:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f04f7f8cd26012e62e96febed3571091fd19f7991cc6f813ff41bbe163658a914b9bd0a01c16e6b5e89603f65ae5c0ae20561357bbad6a629ed82f20b4139e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5bae91027ae1f578f3ddfc3a65e69b0eb63631cbcb449d1ecc75bee1985c23b12b3a9c706c2cb4198345dfdda0a620a8c4d3597664ac22ebb9874a39cdf2627", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f711e160b81d2e98658d76ac0e44987da66f27c5f04d9f34a6165475dcf7eb232d48111126a765c03ea7ddae12fb5b61d13a3e45b2cd448bf9d567c2d8ac465", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4aaa4ceea03fd1c4201e72efd63a4e0a483218a45883255553d582ac54cd039da834cb54c6d7eedca23a5f443507459d220ad064d026806b0ae2d3edef88991"} 11:47:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:11 INFO - Contents: 11:47:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f04f7f8cd26012e62e96febed3571091fd19f7991cc6f813ff41bbe163658a914b9bd0a01c16e6b5e89603f65ae5c0ae20561357bbad6a629ed82f20b4139e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5bae91027ae1f578f3ddfc3a65e69b0eb63631cbcb449d1ecc75bee1985c23b12b3a9c706c2cb4198345dfdda0a620a8c4d3597664ac22ebb9874a39cdf2627", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f711e160b81d2e98658d76ac0e44987da66f27c5f04d9f34a6165475dcf7eb232d48111126a765c03ea7ddae12fb5b61d13a3e45b2cd448bf9d567c2d8ac465", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4aaa4ceea03fd1c4201e72efd63a4e0a483218a45883255553d582ac54cd039da834cb54c6d7eedca23a5f443507459d220ad064d026806b0ae2d3edef88991"} 11:47:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:11 INFO - Copying logs to upload dir... 11:47:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.332985 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-22 11:47:11.803389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 11:47:11.807014) ========= 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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 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/08f04f7f8cd26012e62e96febed3571091fd19f7991cc6f813ff41bbe163658a914b9bd0a01c16e6b5e89603f65ae5c0ae20561357bbad6a629ed82f20b4139e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5bae91027ae1f578f3ddfc3a65e69b0eb63631cbcb449d1ecc75bee1985c23b12b3a9c706c2cb4198345dfdda0a620a8c4d3597664ac22ebb9874a39cdf2627", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f711e160b81d2e98658d76ac0e44987da66f27c5f04d9f34a6165475dcf7eb232d48111126a765c03ea7ddae12fb5b61d13a3e45b2cd448bf9d567c2d8ac465", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4aaa4ceea03fd1c4201e72efd63a4e0a483218a45883255553d582ac54cd039da834cb54c6d7eedca23a5f443507459d220ad064d026806b0ae2d3edef88991"} build_url:https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/O2QMI2-cQHqjA_lN8nP03w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f04f7f8cd26012e62e96febed3571091fd19f7991cc6f813ff41bbe163658a914b9bd0a01c16e6b5e89603f65ae5c0ae20561357bbad6a629ed82f20b4139e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5bae91027ae1f578f3ddfc3a65e69b0eb63631cbcb449d1ecc75bee1985c23b12b3a9c706c2cb4198345dfdda0a620a8c4d3597664ac22ebb9874a39cdf2627", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f711e160b81d2e98658d76ac0e44987da66f27c5f04d9f34a6165475dcf7eb232d48111126a765c03ea7ddae12fb5b61d13a3e45b2cd448bf9d567c2d8ac465", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4aaa4ceea03fd1c4201e72efd63a4e0a483218a45883255553d582ac54cd039da834cb54c6d7eedca23a5f443507459d220ad064d026806b0ae2d3edef88991"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 11:47:11.838957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:47:11.839304) ========= 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=00204705a9daa57ed339a427000001b9-1506101691.561142-505122057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:47:11.924025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 11:47:11.924356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 11:47:11.924720) ========= ========= Total master_lag: 0.21 =========