builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-066 starttime: 1506683608.28 results: success (0) revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.281369) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.281854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.282180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.305081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.305388) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 04:13:28-- 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% 63.6M=0s 2017-09-29 04:13:28 (63.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.441999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.442325) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019663 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.492374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:28.492725) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946b9c995ec331f4f96360409fd8d2fc49e46838 --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 946b9c995ec331f4f96360409fd8d2fc49e46838 --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=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 04:13:28,544 truncating revision to first 12 chars 2017-09-29 04:13:28,545 Setting DEBUG logging. 2017-09-29 04:13:28,545 attempt 1/10 2017-09-29 04:13:28,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946b9c995ec3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 04:13:29,125 unpacking tar archive at: mozilla-central-946b9c995ec3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:29.370852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:29.371267) ========= script_repo_revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:29.371867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:29.372259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 04:13:29.386778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-29 04:13:29.387088) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:29 INFO - MultiFileLogger online at 20170929 04:13:29 in /builds/slave/test 04:13:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:13:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:29 INFO - {'append_to_log': False, 04:13:29 INFO - 'base_work_dir': '/builds/slave/test', 04:13:29 INFO - 'blob_upload_branch': 'Firefox', 04:13:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:29 INFO - 'branch': 'Firefox', 04:13:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:29 INFO - 'code_coverage': False, 04:13:29 INFO - 'config_files': ('talos/linux_config.py',), 04:13:29 INFO - 'default_actions': ('clobber', 04:13:29 INFO - 'read-buildbot-config', 04:13:29 INFO - 'download-and-extract', 04:13:29 INFO - 'populate-webroot', 04:13:29 INFO - 'create-virtualenv', 04:13:29 INFO - 'install', 04:13:29 INFO - 'setup-mitmproxy', 04:13:29 INFO - 'run-tests'), 04:13:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:29 INFO - 'disable_ccov_upload': False, 04:13:29 INFO - 'disable_stylo': False, 04:13:29 INFO - 'download_minidump_stackwalk': True, 04:13:29 INFO - 'download_symbols': 'ondemand', 04:13:29 INFO - 'enable_stylo': False, 04:13:29 INFO - 'enable_webrender': False, 04:13:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:13:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:29 INFO - 'gecko_profile': False, 04:13:29 INFO - 'gecko_profile_interval': 0, 04:13:29 INFO - 'installer_path': 'installer.exe', 04:13:29 INFO - 'log_level': 'info', 04:13:29 INFO - 'log_name': 'talos', 04:13:29 INFO - 'log_to_console': True, 04:13:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:29 INFO - 'opt_config_files': (), 04:13:29 INFO - 'pip_index': False, 04:13:29 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:13:29 INFO - 'system_bits': '32', 04:13:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:29 INFO - 'title': 'talos-linux64-ix-066', 04:13:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:29 INFO - 'use_talos_json': True, 04:13:29 INFO - 'verify': 'False', 04:13:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:29 INFO - 'work_dir': 'build'} 04:13:29 INFO - [mozharness: 2017-09-29 11:13:29.579794Z] Running clobber step. 04:13:29 INFO - Running pre-action listener: _resource_record_pre_action 04:13:29 INFO - Running main action method: clobber 04:13:29 INFO - rmtree: /builds/slave/test/build 04:13:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - [mozharness: 2017-09-29 11:13:31.107220Z] Finished clobber step (success) 04:13:31 INFO - [mozharness: 2017-09-29 11:13:31.107318Z] Running read-buildbot-config step. 04:13:31 INFO - Running pre-action listener: _resource_record_pre_action 04:13:31 INFO - Running main action method: read_buildbot_config 04:13:31 INFO - Using buildbot properties: 04:13:31 INFO - { 04:13:31 INFO - "project": "", 04:13:31 INFO - "product": "firefox", 04:13:31 INFO - "who": "archaeopteryx@coole-files.de", 04:13:31 INFO - "installer_path": "public/build/target.tar.bz2", 04:13:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:13:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:13:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:13:31 INFO - "stage_platform": "linux64-pgo", 04:13:31 INFO - "basedir": "/builds/slave/test", 04:13:31 INFO - "buildnumber": 47, 04:13:31 INFO - "platform": "ubuntu64_hw", 04:13:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:31 INFO - "slavebuilddir": "test", 04:13:31 INFO - "taskId": "O4MxW8bZRVCTJuPqQMYXGg", 04:13:31 INFO - "branch": "mozilla-central", 04:13:31 INFO - "script_repo_revision": "production", 04:13:31 INFO - "revision": "946b9c995ec331f4f96360409fd8d2fc49e46838", 04:13:31 INFO - "slavename": "talos-linux64-ix-066", 04:13:31 INFO - "repo_path": "mozilla-central" 04:13:31 INFO - } 04:13:31 INFO - Finding installer, test and symbols from parent task. 04:13:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4MxW8bZRVCTJuPqQMYXGg'}, attempt #1 04:13:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4MxW8bZRVCTJuPqQMYXGg'}, attempt #1 04:13:32 INFO - Task dependencies: OsRU9v7_RyaOclVwZfen8Q 04:13:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q'}, attempt #1 04:13:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:13:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json 04:13:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip 04:13:32 INFO - Running post-action listener: _resource_record_post_action 04:13:32 INFO - [mozharness: 2017-09-29 11:13:32.515588Z] Finished read-buildbot-config step (success) 04:13:32 INFO - [mozharness: 2017-09-29 11:13:32.515806Z] Running download-and-extract step. 04:13:32 INFO - Running pre-action listener: _resource_record_pre_action 04:13:32 INFO - Running main action method: download_and_extract 04:13:32 INFO - mkdir: /builds/slave/test/build/tests 04:13:32 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')]} 04:13:32 INFO - trying https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json 04:13:32 INFO - Downloading https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:13:33 INFO - Downloaded 989 bytes. 04:13:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:13:33 INFO - Using the following test package requirements: 04:13:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:13:33 INFO - u'common': [u'target.common.tests.zip'], 04:13:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:13:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:13:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:13:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:13:33 INFO - u'mozbase': [u'target.common.tests.zip'], 04:13:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:13:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:13:33 INFO - u'web-platform': [u'target.common.tests.zip', 04:13:33 INFO - u'target.web-platform.tests.tar.gz'], 04:13:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:13:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:13:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip 04:13:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:13:33 INFO - Fetch https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip into memory 04:13:57 INFO - Content-Length response header: 55920898 04:13:57 INFO - Bytes received: 55920898 04:14:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip 04:14:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:14:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip into memory 04:14:09 INFO - Content-Length response header: 14521355 04:14:09 INFO - Bytes received: 14521355 04:14: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')]} 04:14:10 INFO - trying https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:10 INFO - Downloading https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:14:12 INFO - Downloaded 62364334 bytes. 04:14:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:12 INFO - mkdir: /builds/slave/test/properties 04:14:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:12 INFO - Contents: 04:14:12 INFO - build_url:https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:12 INFO - Running post-action listener: _resource_record_post_action 04:14:12 INFO - Running post-action listener: find_tests_for_verification 04:14:12 INFO - Running post-action listener: set_extra_try_arguments 04:14:12 INFO - [mozharness: 2017-09-29 11:14:12.395351Z] Finished download-and-extract step (success) 04:14:12 INFO - [mozharness: 2017-09-29 11:14:12.395449Z] Running populate-webroot step. 04:14:12 INFO - Running pre-action listener: _resource_record_pre_action 04:14:12 INFO - Running main action method: populate_webroot 04:14:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:12 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['tresize', 04:14:12 INFO - 'tcanvasmark']}, 04:14:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:12 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['dromaeo_css', 04:14:12 INFO - 'kraken']}, 04:14:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:12 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'tests': ['damp', 'tps']}, 04:14:12 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['damp', 'tps']}, 04:14:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:12 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['dromaeo_dom']}, 04:14:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:14:12 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['basic_compositor_video', 04:14:12 INFO - 'glvideo']}, 04:14:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:14:12 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['ts_paint_webext', 04:14:12 INFO - 'tp5o_webext']}, 04:14:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:12 INFO - 'ts_paint', 04:14:12 INFO - 'tpaint', 04:14:12 INFO - 'sessionrestore', 04:14:12 INFO - 'sessionrestore_many_windows', 04:14:12 INFO - 'sessionrestore_no_auto_restore', 04:14:12 INFO - 'tabpaint', 04:14:12 INFO - 'cpstartup']}, 04:14:12 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['a11yr', 04:14:12 INFO - 'ts_paint', 04:14:12 INFO - 'tpaint', 04:14:12 INFO - 'sessionrestore', 04:14:12 INFO - 'sessionrestore_many_windows', 04:14:12 INFO - 'sessionrestore_no_auto_restore', 04:14:12 INFO - 'tabpaint', 04:14:12 INFO - 'cpstartup']}, 04:14:12 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:14:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:14:12 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['perf_reftest_singletons']}, 04:14:12 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['perf_reftest']}, 04:14:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:12 INFO - 'tsvgr_opacity', 04:14:12 INFO - 'tart', 04:14:12 INFO - 'tscrollx', 04:14:12 INFO - 'tsvg_static']}, 04:14:12 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['tsvgx', 04:14:12 INFO - 'tsvgr_opacity', 04:14:12 INFO - 'tart', 04:14:12 INFO - 'tscrollx', 04:14:12 INFO - 'tsvg_static']}, 04:14:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:14:12 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--disable-stylo'], 04:14:12 INFO - 'tests': ['tp5o']}, 04:14:12 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:12 INFO - 'talos_options': ['--mitmproxy', 04:14:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:12 INFO - '--firstNonBlankPaint'], 04:14:12 INFO - 'tests': ['tp6_google', 04:14:12 INFO - 'tp6_youtube', 04:14:12 INFO - 'tp6_amazon', 04:14:12 INFO - 'tp6_facebook']}, 04:14:12 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:12 INFO - 'talos_options': ['--disable-stylo', 04:14:12 INFO - '--mitmproxy', 04:14:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:12 INFO - '--firstNonBlankPaint'], 04:14:12 INFO - 'tests': ['tp6_google', 04:14:12 INFO - 'tp6_youtube', 04:14:12 INFO - 'tp6_amazon', 04:14:12 INFO - 'tp6_facebook']}, 04:14:12 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:12 INFO - 'talos_options': ['--stylo-threads=1', 04:14:12 INFO - '--mitmproxy', 04:14:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:12 INFO - '--firstNonBlankPaint'], 04:14:12 INFO - 'tests': ['tp6_google', 04:14:12 INFO - 'tp6_youtube', 04:14:12 INFO - 'tp6_amazon', 04:14:12 INFO - 'tp6_facebook']}, 04:14:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--xperf_path', 04:14:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:12 INFO - 'tests': ['tp5n']}, 04:14:12 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:12 INFO - 'talos_options': ['--disable-stylo', 04:14:12 INFO - '--xperf_path', 04:14:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:12 INFO - 'tests': ['tp5n']}}} 04:14:12 INFO - Running post-action listener: _resource_record_post_action 04:14:12 INFO - [mozharness: 2017-09-29 11:14:12.411228Z] Finished populate-webroot step (success) 04:14:12 INFO - [mozharness: 2017-09-29 11:14:12.411318Z] Running create-virtualenv step. 04:14:12 INFO - Running pre-action listener: _resource_record_pre_action 04:14:12 INFO - Running main action method: create_virtualenv 04:14:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:12 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:14:12 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:14:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:14:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:13 INFO - Installing pip...............done. 04:14:13 INFO - Return code: 0 04:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:14:13 INFO - Reading from file tmpfile_stdout 04:14:13 INFO - Output received: 04:14:13 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:14:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:13 INFO - Using env: {'DISPLAY': ':0', 04:14:13 INFO - 'HOME': '/home/cltbld', 04:14:13 INFO - 'LANG': 'en_US.UTF-8', 04:14:13 INFO - 'LANGUAGE': 'en_US:en', 04:14:13 INFO - 'LOGNAME': 'cltbld', 04:14:13 INFO - 'MAIL': '/var/mail/cltbld', 04:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:13 INFO - 'MOZ_NO_REMOTE': '1', 04:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:13 INFO - 'NO_EM_RESTART': '1', 04:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:13 INFO - 'PWD': '/builds/slave/test', 04:14:13 INFO - 'SHELL': '/bin/bash', 04:14:13 INFO - 'SHLVL': '1', 04:14:13 INFO - 'TERM': 'linux', 04:14:13 INFO - 'TMOUT': '86400', 04:14:13 INFO - 'USER': 'cltbld', 04:14:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:13 INFO - '_': '/tools/buildbot/bin/python'} 04:14:14 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:14:14 INFO - Downloading/unpacking pip>=1.5 04:14:14 INFO - Running setup.py egg_info for package pip 04:14:14 INFO - warning: no files found matching 'pip/cacert.pem' 04:14:14 INFO - warning: no files found matching '*.html' under directory 'docs' 04:14:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:14:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:14:14 INFO - Installing collected packages: pip 04:14:14 INFO - Found existing installation: pip 1.1 04:14:14 INFO - Uninstalling pip: 04:14:14 INFO - Successfully uninstalled pip 04:14:14 INFO - Running setup.py install for pip 04:14:14 INFO - warning: no files found matching 'pip/cacert.pem' 04:14:14 INFO - warning: no files found matching '*.html' under directory 'docs' 04:14:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:14:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:14:14 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:14:14 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:14:14 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:14:14 INFO - Successfully installed pip 04:14:14 INFO - Cleaning up... 04:14:14 INFO - Return code: 0 04:14:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:14 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:14 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 04:14:14 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 04:14:14 INFO - Using env: {'DISPLAY': ':0', 04:14:14 INFO - 'HOME': '/home/cltbld', 04:14:14 INFO - 'LANG': 'en_US.UTF-8', 04:14:14 INFO - 'LANGUAGE': 'en_US:en', 04:14:14 INFO - 'LOGNAME': 'cltbld', 04:14:14 INFO - 'MAIL': '/var/mail/cltbld', 04:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:14 INFO - 'MOZ_NO_REMOTE': '1', 04:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:14 INFO - 'NO_EM_RESTART': '1', 04:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:14 INFO - 'PWD': '/builds/slave/test', 04:14:14 INFO - 'SHELL': '/bin/bash', 04:14:14 INFO - 'SHLVL': '1', 04:14:14 INFO - 'TERM': 'linux', 04:14:14 INFO - 'TMOUT': '86400', 04:14:14 INFO - 'USER': 'cltbld', 04:14:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:14 INFO - '_': '/tools/buildbot/bin/python'} 04:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:14 INFO - Downloading/unpacking psutil>=3.1.1 04:14:14 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 04:14:14 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 04:14:14 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 04:14:14 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 04:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:16 INFO - Installing collected packages: psutil 04:14:16 INFO - Running setup.py install for psutil 04:14:16 INFO - building 'psutil._psutil_linux' extension 04:14:16 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 04:14:16 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 04:14:16 INFO - building 'psutil._psutil_posix' extension 04:14:16 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 04:14:16 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 04:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:16 INFO - Successfully installed psutil 04:14:16 INFO - Cleaning up... 04:14:16 INFO - Return code: 0 04:14:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:16 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')]} 04:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:16 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')]} 04:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:16 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:16 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 04:14:16 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 04:14:16 INFO - Using env: {'DISPLAY': ':0', 04:14:16 INFO - 'HOME': '/home/cltbld', 04:14:16 INFO - 'LANG': 'en_US.UTF-8', 04:14:16 INFO - 'LANGUAGE': 'en_US:en', 04:14:16 INFO - 'LOGNAME': 'cltbld', 04:14:16 INFO - 'MAIL': '/var/mail/cltbld', 04:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:16 INFO - 'MOZ_NO_REMOTE': '1', 04:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:16 INFO - 'NO_EM_RESTART': '1', 04:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:16 INFO - 'PWD': '/builds/slave/test', 04:14:16 INFO - 'SHELL': '/bin/bash', 04:14:16 INFO - 'SHLVL': '1', 04:14:16 INFO - 'TERM': 'linux', 04:14:16 INFO - 'TMOUT': '86400', 04:14:16 INFO - 'USER': 'cltbld', 04:14:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:16 INFO - '_': '/tools/buildbot/bin/python'} 04:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:16 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 04:14:16 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 04:14:16 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 04:14:16 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 04:14:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:17 INFO - Installing collected packages: mozsystemmonitor 04:14:17 INFO - Running setup.py install for mozsystemmonitor 04:14:18 INFO - Successfully installed mozsystemmonitor 04:14:18 INFO - Cleaning up... 04:14:18 INFO - Return code: 0 04:14:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:18 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')]} 04:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:18 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')]} 04:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:18 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:18 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 04:14:18 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 04:14:18 INFO - Using env: {'DISPLAY': ':0', 04:14:18 INFO - 'HOME': '/home/cltbld', 04:14:18 INFO - 'LANG': 'en_US.UTF-8', 04:14:18 INFO - 'LANGUAGE': 'en_US:en', 04:14:18 INFO - 'LOGNAME': 'cltbld', 04:14:18 INFO - 'MAIL': '/var/mail/cltbld', 04:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:18 INFO - 'MOZ_NO_REMOTE': '1', 04:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:18 INFO - 'NO_EM_RESTART': '1', 04:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:18 INFO - 'PWD': '/builds/slave/test', 04:14:18 INFO - 'SHELL': '/bin/bash', 04:14:18 INFO - 'SHLVL': '1', 04:14:18 INFO - 'TERM': 'linux', 04:14:18 INFO - 'TMOUT': '86400', 04:14:18 INFO - 'USER': 'cltbld', 04:14:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:18 INFO - '_': '/tools/buildbot/bin/python'} 04:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:18 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 04:14:18 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 04:14:18 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 04:14:18 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 04:14:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:19 INFO - warning: no files found matching '*.txt' 04:14:19 INFO - no previously-included directories found matching 'build' 04:14:19 INFO - no previously-included directories found matching 'dist' 04:14:19 INFO - no previously-included directories found matching '.git*' 04:14:19 INFO - Installing collected packages: jsonschema, functools32 04:14:20 INFO - Running setup.py install for functools32 04:14:20 INFO - warning: no files found matching '*.txt' 04:14:20 INFO - no previously-included directories found matching 'build' 04:14:20 INFO - no previously-included directories found matching 'dist' 04:14:20 INFO - no previously-included directories found matching '.git*' 04:14:20 INFO - Successfully installed jsonschema functools32 04:14:20 INFO - Cleaning up... 04:14:20 INFO - Return code: 0 04:14:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14:20 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')]} 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:20 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')]} 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:20 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:20 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 04:14:20 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 04:14:20 INFO - Using env: {'DISPLAY': ':0', 04:14:20 INFO - 'HOME': '/home/cltbld', 04:14:20 INFO - 'LANG': 'en_US.UTF-8', 04:14:20 INFO - 'LANGUAGE': 'en_US:en', 04:14:20 INFO - 'LOGNAME': 'cltbld', 04:14:20 INFO - 'MAIL': '/var/mail/cltbld', 04:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:20 INFO - 'MOZ_NO_REMOTE': '1', 04:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:20 INFO - 'NO_EM_RESTART': '1', 04:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:20 INFO - 'PWD': '/builds/slave/test', 04:14:20 INFO - 'SHELL': '/bin/bash', 04:14:20 INFO - 'SHLVL': '1', 04:14:20 INFO - 'TERM': 'linux', 04:14:20 INFO - 'TMOUT': '86400', 04:14:20 INFO - 'USER': 'cltbld', 04:14:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:20 INFO - '_': '/tools/buildbot/bin/python'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:20 INFO - Cleaning up... 04:14:21 INFO - Return code: 0 04:14:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:21 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')]} 04:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:21 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')]} 04:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:21 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:21 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 04:14:21 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 04:14:21 INFO - Using env: {'DISPLAY': ':0', 04:14:21 INFO - 'HOME': '/home/cltbld', 04:14:21 INFO - 'LANG': 'en_US.UTF-8', 04:14:21 INFO - 'LANGUAGE': 'en_US:en', 04:14:21 INFO - 'LOGNAME': 'cltbld', 04:14:21 INFO - 'MAIL': '/var/mail/cltbld', 04:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:21 INFO - 'MOZ_NO_REMOTE': '1', 04:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:21 INFO - 'NO_EM_RESTART': '1', 04:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:21 INFO - 'PWD': '/builds/slave/test', 04:14:21 INFO - 'SHELL': '/bin/bash', 04:14:21 INFO - 'SHLVL': '1', 04:14:21 INFO - 'TERM': 'linux', 04:14:21 INFO - 'TMOUT': '86400', 04:14:21 INFO - 'USER': 'cltbld', 04:14:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:21 INFO - '_': '/tools/buildbot/bin/python'} 04:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:21 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 04:14:21 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 04:14:21 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 04:14:21 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 04:14:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:22 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 04:14:22 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 04:14:22 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 04:14:22 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 04:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:22 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 04:14:22 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 04:14:22 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 04:14:22 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 04:14:22 INFO - Downloading docopt-0.6.1.tar.gz 04:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:22 INFO - Running setup.py install for blobuploader 04:14:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:23 INFO - Running setup.py install for requests 04:14:23 INFO - Running setup.py install for docopt 04:14:23 INFO - Successfully installed blobuploader requests docopt 04:14:23 INFO - Cleaning up... 04:14:23 INFO - Return code: 0 04:14:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:23 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')]} 04:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:23 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')]} 04:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:23 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:23 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 04:14:23 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 04:14:23 INFO - Using env: {'DISPLAY': ':0', 04:14:23 INFO - 'HOME': '/home/cltbld', 04:14:23 INFO - 'LANG': 'en_US.UTF-8', 04:14:23 INFO - 'LANGUAGE': 'en_US:en', 04:14:23 INFO - 'LOGNAME': 'cltbld', 04:14:23 INFO - 'MAIL': '/var/mail/cltbld', 04:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:23 INFO - 'MOZ_NO_REMOTE': '1', 04:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:23 INFO - 'NO_EM_RESTART': '1', 04:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:23 INFO - 'PWD': '/builds/slave/test', 04:14:23 INFO - 'SHELL': '/bin/bash', 04:14:23 INFO - 'SHLVL': '1', 04:14:23 INFO - 'TERM': 'linux', 04:14:23 INFO - 'TMOUT': '86400', 04:14:23 INFO - 'USER': 'cltbld', 04:14:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:23 INFO - '_': '/tools/buildbot/bin/python'} 04:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:23 INFO - Running setup.py (path:/tmp/pip-JhnNN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:23 INFO - Running setup.py (path:/tmp/pip-t54ypU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:23 INFO - Running setup.py (path:/tmp/pip-5Y5HXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:23 INFO - Running setup.py (path:/tmp/pip-j0Tzoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:24 INFO - Running setup.py (path:/tmp/pip-FZET4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:24 INFO - Running setup.py (path:/tmp/pip-Ml37YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:24 INFO - Running setup.py (path:/tmp/pip-4avXCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:24 INFO - Running setup.py (path:/tmp/pip-dpK8Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:24 INFO - Running setup.py (path:/tmp/pip-3X0I6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:24 INFO - Running setup.py (path:/tmp/pip-x8rk0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:24 INFO - Running setup.py (path:/tmp/pip-gB1uGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:24 INFO - Running setup.py (path:/tmp/pip-q6iBsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:24 INFO - Running setup.py (path:/tmp/pip-QdBhTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:24 INFO - Running setup.py (path:/tmp/pip-AU2ysG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:24 INFO - Running setup.py (path:/tmp/pip-JfD_kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:24 INFO - Running setup.py (path:/tmp/pip-e9NciF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:24 INFO - Running setup.py (path:/tmp/pip-sPT7KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:24 INFO - Running setup.py install for manifestparser 04:14:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for mozcrash 04:14:25 INFO - Running setup.py install for mozdebug 04:14:25 INFO - Running setup.py install for mozdevice 04:14:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for mozfile 04:14:25 INFO - Running setup.py install for mozhttpd 04:14:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for mozinfo 04:14:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for mozInstall 04:14:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for mozleak 04:14:25 INFO - Running setup.py install for mozlog 04:14:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Running setup.py install for moznetwork 04:14:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Running setup.py install for mozprocess 04:14:26 INFO - Running setup.py install for mozprofile 04:14:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Running setup.py install for mozrunner 04:14:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Running setup.py install for mozscreenshot 04:14:26 INFO - Running setup.py install for moztest 04:14:26 INFO - Running setup.py install for mozversion 04:14:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:26 INFO - Cleaning up... 04:14:26 INFO - Return code: 0 04:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:26 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:26 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 04:14:26 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 04:14:26 INFO - Using env: {'DISPLAY': ':0', 04:14:26 INFO - 'HOME': '/home/cltbld', 04:14:26 INFO - 'LANG': 'en_US.UTF-8', 04:14:26 INFO - 'LANGUAGE': 'en_US:en', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MAIL': '/var/mail/cltbld', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SHLVL': '1', 04:14:26 INFO - 'TERM': 'linux', 04:14:26 INFO - 'TMOUT': '86400', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - '_': '/tools/buildbot/bin/python'} 04:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:26 INFO - Running setup.py (path:/tmp/pip-DIuNmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:26 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)) 04:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:26 INFO - Running setup.py (path:/tmp/pip-OYVZZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:27 INFO - Running setup.py (path:/tmp/pip-HoGqcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:27 INFO - Running setup.py (path:/tmp/pip-IGNx7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:27 INFO - Running setup.py (path:/tmp/pip-OVNBrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:27 INFO - Running setup.py (path:/tmp/pip-KjK2hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:27 INFO - Running setup.py (path:/tmp/pip-A1oCxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:27 INFO - Running setup.py (path:/tmp/pip-nya8LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:27 INFO - Running setup.py (path:/tmp/pip-DFkVky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:27 INFO - Running setup.py (path:/tmp/pip-_y2QXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:27 INFO - Running setup.py (path:/tmp/pip-bsW7TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:27 INFO - Running setup.py (path:/tmp/pip-5L_B28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:27 INFO - Running setup.py (path:/tmp/pip-76dFbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:27 INFO - Running setup.py (path:/tmp/pip-F5ViLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:27 INFO - Running setup.py (path:/tmp/pip-xsAAQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:27 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)) 04:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:27 INFO - Running setup.py (path:/tmp/pip-pVrM9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:28 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)) 04:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:28 INFO - Running setup.py (path:/tmp/pip-qcAclw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:28 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)) 04:14:28 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)) 04:14:28 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)) 04:14:28 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)) 04:14:28 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)) 04:14:28 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)) 04:14:28 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)) 04:14:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:28 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 04:14:28 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 04:14:28 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 04:14:28 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 04:14:29 INFO - Downloading blessings-1.6.tar.gz 04:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:29 INFO - Installing collected packages: blessings 04:14:29 INFO - Running setup.py install for blessings 04:14:29 INFO - Successfully installed blessings 04:14:29 INFO - Cleaning up... 04:14:29 INFO - Return code: 0 04:14:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:29 INFO - Reading from file tmpfile_stdout 04:14:29 INFO - Current package versions: 04:14:29 INFO - argparse == 1.2.1 04:14:29 INFO - blessings == 1.6 04:14:29 INFO - blobuploader == 1.2.4 04:14:29 INFO - docopt == 0.6.1 04:14:29 INFO - functools32 == 3.2.3-2 04:14:29 INFO - jsonschema == 2.5.1 04:14:29 INFO - manifestparser == 1.1 04:14:29 INFO - mozInstall == 1.13 04:14:29 INFO - mozcrash == 1.0 04:14:29 INFO - mozdebug == 0.1 04:14:29 INFO - mozdevice == 0.51 04:14:29 INFO - mozfile == 1.2 04:14:29 INFO - mozhttpd == 0.7 04:14:29 INFO - mozinfo == 0.10 04:14:29 INFO - mozleak == 0.1 04:14:29 INFO - mozlog == 3.5 04:14:29 INFO - moznetwork == 0.27 04:14:29 INFO - mozprocess == 0.25 04:14:29 INFO - mozprofile == 0.28 04:14:29 INFO - mozrunner == 6.13 04:14:29 INFO - mozscreenshot == 0.1 04:14:29 INFO - mozsystemmonitor == 0.3 04:14:29 INFO - moztest == 0.8 04:14:29 INFO - mozversion == 1.4 04:14:29 INFO - psutil == 3.1.1 04:14:29 INFO - requests == 1.2.3 04:14:29 INFO - wsgiref == 0.1.2 04:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:29 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:29 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 04:14:29 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 04:14:29 INFO - Using env: {'DISPLAY': ':0', 04:14:29 INFO - 'HOME': '/home/cltbld', 04:14:29 INFO - 'LANG': 'en_US.UTF-8', 04:14:29 INFO - 'LANGUAGE': 'en_US:en', 04:14:29 INFO - 'LOGNAME': 'cltbld', 04:14:29 INFO - 'MAIL': '/var/mail/cltbld', 04:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:29 INFO - 'MOZ_NO_REMOTE': '1', 04:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:29 INFO - 'NO_EM_RESTART': '1', 04:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:29 INFO - 'PWD': '/builds/slave/test', 04:14:29 INFO - 'SHELL': '/bin/bash', 04:14:29 INFO - 'SHLVL': '1', 04:14:29 INFO - 'TERM': 'linux', 04:14:29 INFO - 'TMOUT': '86400', 04:14:29 INFO - 'USER': 'cltbld', 04:14:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:29 INFO - '_': '/tools/buildbot/bin/python'} 04:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 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)) 04:14:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:14:29 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 04:14:29 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 04:14:29 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 04:14:29 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 04:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:14:31 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)) 04:14:31 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)) 04:14:31 INFO - Installing collected packages: simplejson 04:14:31 INFO - Running setup.py install for simplejson 04:14:31 INFO - building 'simplejson._speedups' extension 04:14:31 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 04:14:31 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 04:14:32 INFO - Successfully installed simplejson 04:14:32 INFO - Cleaning up... 04:14:32 INFO - Return code: 0 04:14:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:32 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')]} 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:32 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')]} 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:32 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 0x1a991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c61b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', '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 04:14:32 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 04:14:32 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 04:14:32 INFO - Using env: {'DISPLAY': ':0', 04:14:32 INFO - 'HOME': '/home/cltbld', 04:14:32 INFO - 'LANG': 'en_US.UTF-8', 04:14:32 INFO - 'LANGUAGE': 'en_US:en', 04:14:32 INFO - 'LOGNAME': 'cltbld', 04:14:32 INFO - 'MAIL': '/var/mail/cltbld', 04:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:32 INFO - 'MOZ_NO_REMOTE': '1', 04:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:32 INFO - 'NO_EM_RESTART': '1', 04:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:32 INFO - 'PWD': '/builds/slave/test', 04:14:32 INFO - 'SHELL': '/bin/bash', 04:14:32 INFO - 'SHLVL': '1', 04:14:32 INFO - 'TERM': 'linux', 04:14:32 INFO - 'TMOUT': '86400', 04:14:32 INFO - 'USER': 'cltbld', 04:14:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:32 INFO - '_': '/tools/buildbot/bin/python'} 04:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:32 INFO - Cleaning up... 04:14:32 INFO - Return code: 0 04:14:32 INFO - Running post-action listener: _resource_record_post_action 04:14:32 INFO - Running post-action listener: _start_resource_monitoring 04:14:32 INFO - Starting resource monitoring. 04:14:32 INFO - [mozharness: 2017-09-29 11:14:32.399069Z] Finished create-virtualenv step (success) 04:14:32 INFO - [mozharness: 2017-09-29 11:14:32.399581Z] Running install step. 04:14:32 INFO - Running pre-action listener: _resource_record_pre_action 04:14:32 INFO - Running main action method: install 04:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:32 INFO - Reading from file tmpfile_stdout 04:14:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:32 INFO - Reading from file tmpfile_stdout 04:14:32 INFO - Output received: 04:14:32 INFO - Usage: mozinstall [options] installer 04:14:32 INFO - Options: 04:14:32 INFO - -h, --help show this help message and exit 04:14:32 INFO - -d DEST, --destination=DEST 04:14:32 INFO - Directory to install application into. [default: 04:14:32 INFO - "/builds/slave/test"] 04:14:32 INFO - --app=APP Application being installed. [default: firefox] 04:14:32 INFO - mkdir: /builds/slave/test/build/application 04:14:32 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'] 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:14:50 INFO - Reading from file tmpfile_stdout 04:14:50 INFO - Output received: 04:14:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:50 INFO - Running post-action listener: _resource_record_post_action 04:14:50 INFO - [mozharness: 2017-09-29 11:14:50.424418Z] Finished install step (success) 04:14:50 INFO - [mozharness: 2017-09-29 11:14:50.424667Z] Running setup-mitmproxy step. 04:14:50 INFO - Running pre-action listener: _resource_record_pre_action 04:14:50 INFO - Running main action method: setup_mitmproxy 04:14:50 INFO - Skipping: mitmproxy is not required 04:14:50 INFO - Running post-action listener: _resource_record_post_action 04:14:50 INFO - [mozharness: 2017-09-29 11:14:50.425976Z] Finished setup-mitmproxy step (success) 04:14:50 INFO - [mozharness: 2017-09-29 11:14:50.426194Z] Running run-tests step. 04:14:50 INFO - Running pre-action listener: _resource_record_pre_action 04:14:50 INFO - Running pre-action listener: _set_gcov_prefix 04:14:50 INFO - Running main action method: run_tests 04:14:50 WARNING - Try message not found. 04:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:50 INFO - Python 2.7.3 04:14:50 INFO - Return code: 0 04:14:50 INFO - grabbing minidump binary from tooltool 04:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:50 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 0x1e03d60>, '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 0x1e04a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e04ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:50 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 04:14:50 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 04:14:50 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 04:14:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:50 INFO - Return code: 0 04:14:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:50 INFO - ENV: RUST_BACKTRACE is now full 04:14:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 04:14:50 INFO - Using env: {'DISPLAY': ':0', 04:14:50 INFO - 'HOME': '/home/cltbld', 04:14:50 INFO - 'LANG': 'en_US.UTF-8', 04:14:50 INFO - 'LANGUAGE': 'en_US:en', 04:14:50 INFO - 'LOGNAME': 'cltbld', 04:14:50 INFO - 'MAIL': '/var/mail/cltbld', 04:14:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:50 INFO - 'MOZ_NO_REMOTE': '1', 04:14:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:50 INFO - 'NO_EM_RESTART': '1', 04:14:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:50 INFO - 'PWD': '/builds/slave/test', 04:14:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:50 INFO - 'RUST_BACKTRACE': 'full', 04:14:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:14:50 INFO - 'SHELL': '/bin/bash', 04:14:50 INFO - 'SHLVL': '1', 04:14:50 INFO - 'TERM': 'linux', 04:14:50 INFO - 'TMOUT': '86400', 04:14:50 INFO - 'USER': 'cltbld', 04:14:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:50 INFO - '_': '/tools/buildbot/bin/python'} 04:14:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:14:50 INFO - mozversion application_buildid: 20170929094722 04:14:50 INFO - mozversion application_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 04:14:50 INFO - mozversion application_display_name: Nightly 04:14:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:50 INFO - mozversion application_name: Firefox 04:14:50 INFO - mozversion application_remotingname: firefox 04:14:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:50 INFO - mozversion application_vendor: Mozilla 04:14:50 INFO - mozversion application_version: 58.0a1 04:14:50 INFO - mozversion platform_buildid: 20170929094722 04:14:50 INFO - mozversion platform_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 04:14:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:50 INFO - mozversion platform_version: 58.0a1 04:14:50 INFO - using testdate: 1506683690 04:14:50 INFO - actual date: 1506683690 04:14:50 INFO - starting webserver on 'localhost:45096' 04:14:50 INFO - SUITE-START | Running 2 tests 04:14:50 INFO - TEST-START | dromaeo_css 04:14:50 INFO - Initialising browser for dromaeo_css test... 04:14:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45096/getInfo.html -profile /tmp/tmpG6Kyof/profile 04:14:50 INFO - TEST-INFO | started process 17691 (/builds/slave/test/build/application/firefox/firefox http://localhost:45096/getInfo.html) 04:14:56 INFO - TEST-INFO | 17691: exit 0 04:14:57 INFO - Browser initialized. 04:14:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:57 INFO - Using env: {'DISPLAY': ':0', 04:14:57 INFO - 'HOME': '/home/cltbld', 04:14:57 INFO - 'JSGC_DISABLE_POISONING': '1', 04:14:57 INFO - 'LANG': 'en_US.UTF-8', 04:14:57 INFO - 'LANGUAGE': 'en_US:en', 04:14:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:14:57 INFO - 'LOGNAME': 'cltbld', 04:14:57 INFO - 'MAIL': '/var/mail/cltbld', 04:14:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:57 INFO - 'MOZ_CRASHREPORTER': '1', 04:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:14:57 INFO - 'MOZ_NO_REMOTE': '1', 04:14:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:57 INFO - 'NO_EM_RESTART': '1', 04:14:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:57 INFO - 'PWD': '/builds/slave/test', 04:14:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:57 INFO - 'RUST_BACKTRACE': 'full', 04:14:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:14:57 INFO - 'SHELL': '/bin/bash', 04:14:57 INFO - 'SHLVL': '1', 04:14:57 INFO - 'STYLO_FORCE_DISABLED': '1', 04:14:57 INFO - 'TERM': 'linux', 04:14:57 INFO - 'TMOUT': '86400', 04:14:57 INFO - 'USER': 'cltbld', 04:14:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:57 INFO - '_': '/tools/buildbot/bin/python'} 04:14:57 INFO - TEST-INFO | started process 17928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG6Kyof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:57 INFO - PID 17928 | 04:14:57 INFO - PID 17928 | (/builds/slave/test/build/application/firefox/firefox:17978): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:14:57 INFO - PID 17928 | 04:15:08 INFO - PID 17928 | RSS: Main: 145776640 04:15:08 INFO - PID 17928 | 04:18:04 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45096/tests/dromaeo/cssquery-ext.html) 04:18:05 INFO - PID 17928 | RSS: Main: 143466496 04:18:05 INFO - PID 17928 | 04:21:07 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-ext.html (next: http://localhost:45096/tests/dromaeo/cssquery-jquery.html) 04:21:08 INFO - PID 17928 | RSS: Main: 143982592 04:21:08 INFO - PID 17928 | 04:24:09 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45096/tests/dromaeo/cssquery-mootools.html) 04:24:10 INFO - PID 17928 | RSS: Main: 145555456 04:24:10 INFO - PID 17928 | 04:27:11 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45096/tests/dromaeo/cssquery-prototype.html) 04:27:12 INFO - PID 17928 | RSS: Main: 145256448 04:27:12 INFO - PID 17928 | 04:30:15 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45096/tests/dromaeo/cssquery-yui.html) 04:30:16 INFO - PID 17928 | RSS: Main: 148123648 04:30:16 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:45096/tests/dromaeo/cssquery-yui.html (next: http://localhost:45096/tests/dromaeo/cssquery-dojo.html) 04:33:17 INFO - PID 17928 | RSS: Main: 149372928 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | __start_tp_report 04:33:17 INFO - PID 17928 | _x_x_mozilla_page_load 04:33:17 INFO - PID 17928 | _x_x_mozilla_page_load_details 04:33:17 INFO - PID 17928 | |i|pagename|runs| 04:33:17 INFO - PID 17928 | |0;dojo.html;3777.414500752383;3856.86500972466;3864.246471937973;3885.0093226227327;3897.785621790801;6031.125486804422;6118.908216376747;6136.447719705231;6146.8463288417815;6216.285127210373;6224.439800417961;6265.780697675571;6267.874642507147;6288.559800813945;6314.052892066193;5579.497845193931;5625.324961004685;5656.349519805223;5660.745266462998;5674.489295963363;275.38451560761706;5609.074502707049;5651.2935883014625;5692.857678558028;5697.8575535611735;5226.92159617606;5531.889362212753;5564.610477266593;5602.943970560283;5637.9718101409435;5515.145152501369;5573.804916827932;5651.886962260773;5652.434756524356;5652.63257888236;5558.333000039981;5564.304461942257;5641.746121424546;5642.633228840113;5646.350669672999;6045.6070355426755;6109.877802443971;6115.205023346981;6126.693665316717;6208.689565521706;6529.5429319947625;6644.634545100018;6657;6739.090222819906;6742.966285168592;6658.966705166492;6702.262751097375;6758.932410675929;6793.694283757193;6838.008488769101;6304.117423560705;6346.587471814318;6376.234851817811;6387;6400.583962042452;6907.34380233882;6945.236024037352;6951.270116637781;7007.159140903124;7036;6531.608103513804;6648.933510664831;6683.966580167068;6768.187817461936;6773.187217533928;6705.463562914955;6738.124043874265;6777.661116944133;6813.488988325896;6831.385175334144;6738.124043874363;6781.050652908597;6789.490788190906;6795.2185498667295;6802.897956530656;6703.296153903867;6733.091032710619;6734.797956061326;6819.147606549182;6821.658917054127;4864;4931.112399768076;4979.029089327546;4980.103581355318;4980.775865086008;4506.3916371290115;4519.570640789119;4578.175928332866;4585.335126406652;4597.057603191338;6174.041077088114;6176.073588961692;6249.875002499924;6256.6871656417;6270.749170033238;6507.414332710079;6607.273199948002;6681.966590167115;6749.0551322814845;6761.628110453972;6148.354422785633;6164.260288765287;6181.660008699475;6192.071189321638;6195;5431.864203394868;5497.038018346773;5497.39528651848;5504.752286147133;5511.696856672921;6938.236793952661;6943;6954.4436445084275;7027.789166325018;7049.8237544060785;6702.430293425114;6788.694508747119;6796;6797;6800.387965083265;6989.231184569795;6989.720411183495;7042.401395881408;7077.433805295667;7102.431805455654;6589.209294884645;6603.174603174603;6679.298673639198;6688.933110668831;6729.259781424137;6675.632840193836;6737.629430381376;6739.595624262364;6751.966240168767;6752.696128674123;6363.886319894093;6480.611163330215;6514.837129071811;6528.183977002875;6536.803895883131;6415.037744338387;6426.550141490051;6493.7727179550375;6513.413792758674;6514.9348506514325;6289.528285378707;6302.243730752339;6327.335629758809;6410.743570257137;6422.068800024063;6519.511036672174;6538.803835884931;6602.471802255904;6609.570377925612;6612.40488356031;6352.936470635234;6356.68216589178;6356.745730170742;6388.4569811566535;6404.327545607644 04:33:17 INFO - PID 17928 | |1;ext.html;956.9138777510032;964.7105868239531;987.4223579206164;1016.2936758952528;1017.9796404071918;44758.32862507061;45802.77098614511;45876.54123458768;46007.76996115023;46014.769926150366;45653.7717311413;47076;47095.52904470954;47238.76380618092;47369;8454.61954212062;8547;8554.059053504141;8555.828883422328;8560.657573697075;8361.581920903931;8487.321014318839;8488.78778030548;8490.066092729794;8490.575471226444;8488.490690558556;8489.702860399888;8552.315814734837;8556.828863422728;8585.699500517483;8484.19400156984;8488.872666910001;8512.319014478826;8519.318454523685;8521.318294536422;8018.478798878113;8020.839583208362;8045;8053.516788992679;8058.073321568036;42467.575324246674;42992.35511467331;43026.35460468096;43323;43366.349504757454;3768.6419790119894;3778.4710140580064;3791.639794219545;3806.695464362844;3814.618538146191;33947.490787638206;34044.65955340464;34049;34064.659353406394;34108.82945585281;5174.508421699932;5396.64921780083;5422.43064478232;5456.290682211287;5494.2582751328455;241102;241489;243161;243433;243710;54858.45141548533;55100.448995510334;55555.7777688896;55602.443975560534;55902;58356.4164358351;58638.70680646655;58675.41324586785;58776.41223587709;58782.70608646929;16549.338026478807;16645.084520351254;16654.08402537872;16656.58358541022;17855.821441785676;14365;14411.279436028157;14413.639659008608;14420.351084201237;14422.350994205286;16190.75713864293;16256.837431625769;16288.104154271628;16291;16337.591560211089;6258.624482531062;6279.874402511924;6291.307956124822;6423.325550817191;6523.836904077341;1115.866096068477;1115.9051480624075;1119.8152304869768;1121.9382933938712;1129.5707631100129;25672.743272567408;26196.34509137249;26239.475210495682;26365.9453621853;26530.204093877215;1202.7654607351483;1227.1042139238407;1238.3127364312713;1253.9122261441794;1259.7921342978489;13559.118657287245;13699.931500342434;13918.860811391958;13994.790078148835;14215.502457414148;292234;293660;293846;294907;295175;51419.228711569354;52159;59381.10928336078;59684.701576492705;60560.697196513735;1560.6410525578954;1591;1591.172590253062;1595.4017243533674;1599.1045014791755;31468;31576.526352104276;32200;32468.35063298768;32470;42775.144497109264;42823.35764963466;42855;42895;43016.139677206906;240241;241698;241847;241962;242013;37926;38763.612363876004;38836.22327553377;39400.211995760495;39591.40612890867;48784.51215487942;48980.51019489759;49132.508674912795;49445.280509572316;49521.75239123782;33993.490097648064;34568.48147277743;35265.47101793424;35339.29321413609;36300.27399452049;34679.306413871076;34803;34838.303233934676;35456;35515.112122197155;40288;41259.587404125574;41505.1698966025;41723.7913810429;42161.36757948695;33589.16027099244;33899.66100338965;34179.4873076909;34436.31127377489;34680.13299667528;26185.476290473704;26189.214323570322;26210.213693589223;26218;26234.73765262323 04:33:17 INFO - PID 17928 | |2;jquery.html;613.6931534232883;637.063516630553;637.2083098946715;638.6427385932388;641.7070386934649;23012.079516819307;23317.183898563533;23675.881620591917;23905.043798248073;23998.760012399893;26183.214503564923;26599.335016624595;26653.600195997074;26682.866585667045;26774.33064173392;6475.611463312192;6671.899921501157;6680.699368528403;6681.832954176136;6686.465082793365;6125.754969801203;6645.435138013275;6914.861702765942;6928.757493487729;6933.965330173342;6826.965865170667;6862.176538815324;6869.072675188835;6870.072540207083;6870.587764734107;6511.641859697715;6767.593944363305;6804.65976701163;6840.828979275509;6841.418479429254;6293.527985401113;6327.905081423783;6377.234731832164;6382.936170638281;6388.968055159741;29433.41133177346;29871.551926721117;29932.251693707833;29986.700132998827;30052;2243.091547923094;2254.1434254983164;2256.435891027243;2264.671622614712;2266.660000999847;19425.708614370797;20847;20865.89567052155;20919.26782562603;20991.89504052485;2517.0812653381568;2530.772230499264;2577.9613305800426;2675.357914100621;2678.1965410377;143436;148335;166352;170957.14521427313;171969;16476.505704828873;16485.423010194587;16861.31386861304;16901.23944422504;17212.39756608513;26976.32559186036;27051.594226086625;27102.5934610981;27131.186064417703;27142;11193.16051296156;11260.94369528147;11368.886311136948;11402.144839137098;11417.372044537464;10312.948435257926;10359.223058270509;10364.170866330676;10401.84397234042;10415.270931034755;10149.34029288094;10304.227182961307;10352.5341359639;10426.791464170827;10472.528736206888;3097.4889143291102;3098.4762247119006;3131.9530207046914;3142.447995928469;3274.6397896231397;1023.6007956896816;1040.5317607076845;1044.9582016719246;1051.0855555666467;1057.3391630231106;20730.48173795667;21029.789702102782;21105.155793768383;21131.683024754642;21630.13479460804;1088;1100.3287994323457;1114.4316398636754;1124.2579897267929;1126.2735535579668;11369.602063927723;11386.715332116763;11570;11598.478068486938;11693.356865372316;598060;609289;615262;619895;623138;133891;137097;137745.311273443;139021;142065;1219.359836086062;1232.4700378837185;1256.0579565326007;1260.9054320925968;1265.8038004109194;18190.90904545469;18556.907215463838;18829.529261768566;19031.238750449826;19041.143148558625;61966.69016654888;62543.374566255574;63176.36823631705;64526;64871.67564162149;77355.2264477348;77496.61251693705;78243.2175678236;79152.20847791448;80065;15623.218839057774;15792.447264345692;15862.841371586137;15901.125438100553;15911.124888131264;23079.653805193273;23452.296431107094;23789.64315535303;23943;24220.75779242185;17310.82689173092;17342;17552.648947020734;18930.621387571897;19631.509212269808;17256.396026139024;17450.47648570545;17534.298628054734;17985.820141798413;18085;17302.480925572254;17386.21762020687;19424.70862937029;20108.39674809758;20369.49076273105;15261.771073433685;15440.382384704486;15460.304286307368;15524.534263972098;15566.143862087694;18903.149358278635;19030.809691903458;19158.90420547944;19304.420867374;19394.127264272858 04:33:17 INFO - PID 17928 | |3;mootools.html;1386.8405133409656;1463.3707505772527;1468.897177197596;1471.9916856952984;1475.8007668964688;16547.58631034225;17129.914350428247;18084.81915180848;18119.909400453012;18144.909275453603;17564.385246516373;17825.643487130248;17837;17867.553311167227;17920.731189032176;2393.7845593896545;2823.294176455881;2825.66092068951;2831.362943337753;2833.7874659400522;2827.971720282802;2837.1914004508717;2872.3250036241466;2873.281679580105;2875.3674191677796;2819.0556163685087;2822.887084516617;2878.409925965172;2891.277180704824;2898.4637841999297;2795.9860200699068;2831.730985556369;2837.6311079559628;2842.4457230839994;2847.829130252181;2818.9859050704617;2824.8728807203725;2829.2502486841004;2837.5459926411677;2842.616246806696;16681.83318166815;16807.495775126765;17061;17075.316987320493;17083.06043167625;8647.610857511427;8943.463392196489;8967.68613098545;8995.460272383678;9004.729858104267;5530.6128571000045;5703.7148142592705;5710.857228569277;5765.077587586008;5849.444302791228;2123.1189056541516;2135.6187850546685;2143.3034263864306;2207.7902599253043;2209.0501084533644;30783.384332313453;31033.68966310353;31213.531797022835;31321.216969575715;31444.37111257785;8007.119216886138;8161.551114688749;8171.959140204261;8360.958195208985;8363.540005299645;23685.644715329283;23715.051397943887;23764.64353034671;23793.620637936066;23832.7616723834;7863.882041769378;8852.557372131369;9028.368014239071;9031.232345250728;9049.230815380635;6636.502262330345;7188.137423509213;7838.725644602526;8139.79650508742;8212.63043163059;6101.267847858286;6230.968845155745;6243.75024999004;6320.399562041599;6342.4926005919415;1893.3089422361015;1966.3904189701238;1970.359633119242;1973.6052789441883;2004.418718571598;1023.698009087321;1040.1834559870465;1043.0612448795991;1053.89461053894;1064.2550214849637;8899.644014239488;8902.643894244158;8915.153060459246;8939.776505587412;9005.729828105168;814.5519964019766;823.115151212437;838.9538575378413;841.54556539468;848.7793173774863;5312.628116031918;6232.470240029557;6259.593126446766;6290.622562646256;6298.370162983757;24255.75744242535;25412.745872541407;25512.617310740352;25576.744232557437;25734.48531029369;23676.763232367455;25398.619020714705;25451.61822572663;25462;25475.74524254734;12598.56684556098;12881.291528965998;13137.146085504412;13201.207927524187;13201.20792752438;9649.276304277348;9723.46520941355;9771.560279787285;9795.951020244853;9875.209983201183;21651.783482165607;21758;21851.781482184975;22343.888280558494;22951.54096918019;21796.128154873626;21883;22291.219807306665;22310.442238944157;22371;14152.080114792505;14211.715765684421;14275.214863182624;14291.64270893236;14339.283035848375;15737.213139342759;15917.363305467652;15918.60203494922;15926.601834953755;15938.36246550125;12175.573854915036;12520.373981301082;12611.306378148924;12729.108962372546;12737.80893286583;11965;12227.266364018187;12484.937575312066;12486.250824950532;12619.81070283928;10787.406692631981;11061.225714199929;11070.889291106985;11088.5564577416;11090.5563777448;8567.657293708182;8655.394122411622;8666.956665216885;8777.990531089006;8839.337049721167;8476.321894248322;8674.522901240493;8696.478211307089;8749.343799214957;8785.253253473526 04:33:17 INFO - PID 17928 | |4;prototype.html;548.3693752184987;568.1421054208146;568.9146628005801;579.7246308003697;581.874896897167;6327.746890124389;6333.366663333664;6338.271098823637;6360.427561519462;6386.808395748123;6233.376662333764;6234.812955611327;6266.811995640127;6269.561130720851;6279.591826531284;5157.174852023677;5168.8707782305555;5170.276161337416;5170.715610641413;5176.689398636075;4955.826546070888;5135.589152867761;5143.736755827424;5192.922106168392;5197.48025197481;5027.472115427882;5038.420581633104;5052.797888084472;5060.291559181699;5063.215201643751;5040.798368065273;5043.360907704974;5043.722595257259;5062.417821950467;5076.162433198518;4483.753393563353;4568.588827005586;4599.2871104978785;4627.120847039052;4630.884227894296;6089.756409743605;6140.478059364959;6141.508679305645;6191.133241346215;6213.378662133796;5888.499477544414;5908.5228692826795;5916.171735956969;5931.555133364972;5997.430244126801;6738.730450781963;6742.258351581322;6753.358430949052;6762.661866906635;6787.830304242384;5210.270562121306;5217.973910130463;5218.086834803932;5220.765065572058;5240;6618.93381066188;6709;6889.931100688979;6947.818870791927;6959.3736563709;5242.633015688942;5247.425772268304;5259.894802103937;5317.8936421271355;5347.385050719139;5378.870437208152;5393.465071416428;5404.83785486436;5412.972935135378;5445.455454454523;5857.58996870215;5926.970365148233;5935.465808077293;5940.34656187819;5953.970230148908;6652.368025037614;6683.398494135551;6687.030380594787;6693.899591506131;6704.659068186383;1822.5874946916247;1863.2174486715612;1872.4008317338594;1873.2881505028001;1876.9155388007573;1285.4408332375447;1326.4230059923964;1335.485837952376;1339.564641491519;1352.60774375432;6008.394963022151;6042.123892035718;6060.454559089703;6073.605215660968;6186.257649082139;6511.28375878653;6584.209894812558;6589.769358072444;6606.306337834554;6699;6070.2412198475195;6085.208922840003;6101.938980610226;6122.948812147892;6157.445829875243;3489.7382696297877;3494.650534946536;3522.9119272018406;3524.788512689247;3530.9646903531147;6904;6921.342472465108;6956.365254165267;7042.542234754725;7101.147862256562;6785.287544807823;6798.422134118655;6878.58728476283;6930.965345173242;6956.200036995709;6940.548864323803;6946.93053069473;7015.964920175468;7042.507024508235;7043.295670432915;6627.502937279627;6642.833929151617;6676.132102826601;6688.7324507019175;6707.396334329934;6594.274629790815;6604.8348791280605;6682;6704.66476676174;6710.396064354231;6816.727330906709;6818.352256535622;6939.444844412334;6950.8609827804175;6969.442444604318;5244.318238629106;5274.077036518671;5312.123499622519;5326.547243484347;5338.839834804962;6618;6748.426383757435;6779.847425937701;6800.82997925036;6802.387785099365;6022.307434645072;6492.38322359394;6531.11829902957;6555.737770489127;6580.374864387875;6458.22501299847;6460.806175814733;6495.610263384023;6556.475481961336;6631.237407697983;6453.515986300952;6459.386358295955;6471.676416179266;6523.347665233438;6535.496835727714;6602.40578347951;6623.039659249478;6627.304133065959;6688.8929987053925;6702.726481968411;6358.745650173942;6427.196600424947;6443.0335449682925;6455.61266324022;6466.371968731899 04:33:17 INFO - PID 17928 | |5;yui.html;960.433344326847;970.2383628851351;995.7859060302034;996.2080146283704;1000.7448100734312;18814;19127.904360478176;19131.234750609994;19133.712994305097;19180.0409979501;19090.713639295423;19545.804541954578;19623.509412264666;19784.70322945157;19897;1028.8250997330454;1056.7939251845894;1057.7567159553307;1058.7776566920957;1058.9947050264739;1045.5190612318343;1078.1698092468835;1081.1512962324578;1081.8809930907594;1085.592902661502;1136.2727854173336;1142.8799976002483;1144.1247445704043;1144.622274649368;1144.914131440141;1095.1239008792934;1126.5268587193316;1136.318209074557;1139.0432037088844;1146.1633007904236;797.5852556670499;812.4110020235341;815.229608020421;815.5514467043103;817.3297895725508;20609.690854637192;20753.377398678065;20860.165593376245;20923.05846236923;20960.790392096038;21519.246826361003;21690.674639880413;22075.558488830135;22260.666090008664;22369.328920132422;18311.175997080165;18949;18992.14535345899;19044.0477976102;19171.32900348481;3916.020994751312;3953.9011524711823;3955.564887862333;3959.663428608572;3962.643362097396;165296;165934;166430;167284.16357918255;170405.1479742606;17811.821881781274;17915;17934.372296969545;18053.7291940621;18123.36568220106;32523.837380812944;34621.826890865384;34883;34970.30059398849;35129.64870351315;9826.705198844045;9864.506774661239;9874.259430542594;9889.851652225223;9894.703158905244;4814.301926220678;4831.251156070814;4885.316055752198;4907.312976183337;4929.038837426668;6076.179715738407;6157.230346206724;6160.199174107337;6166.907496387557;6172.290186628506;1133.1954312438097;1150.4075401168404;1166.125405945541;1176.2413243458093;1180.0205829161775;719.2196466833544;727.7743899391205;739.9704011839466;740.8925705772633;761.8362052158701;12904.16122952005;13306.401211945486;13746.518871839438;14049.859501404855;14259.714805704036;709.4359983812881;718.9173245076884;721.2354903801987;733.069002366991;739.5599618227146;6344.460720838688;6388.584741991848;6436.806895793134;6445.806625801233;6464.353564643498;158067.20966395325;158186;158704;163965;166177;139266;139421.60578394087;140524;140824;144897;120812;122246.38876805559;124099.37950310191;124822;125099.37450312873;11900.464479098287;12012.75974480488;12041.157119001586;12169.878301216875;12256.448459819152;57693.71153144207;57714.33131821087;57847.4215257842;58622.41377586169;59125.70437147787;72425.27574724186;73309.26690733024;73881.04475821122;73939.63030184814;76394.61802691173;15675.294611742727;15762.290696918437;15823.129727865078;15894.52316430509;15941.36234550605;19470.12384442675;19594;19962.60074798525;19968.50078748043;20091;15017.624559385666;15075.924620376827;15356.692866142837;15476.690466190837;15595.844041559893;16699.66600668004;16736.832631674013;16912.32350705958;16965.491035268962;17077.74383384275;15612.687746244785;15614.609634759221;15692.215389230721;15782.605434864221;15931.681366372839;12517.311547864954;12561.43473543711;12565.623031309075;12622.116451848282;12632.557860474839;13302.334883255606;13445;13513.324333783468;13589.796153057514;13641 04:33:17 INFO - PID 17928 | __end_tp_report 04:33:17 INFO - PID 17928 | __start_cc_report 04:33:17 INFO - PID 17928 | _x_x_mozilla_cycle_collect,280 04:33:17 INFO - PID 17928 | __end_cc_report 04:33:17 INFO - PID 17928 | __startTimestamp1506684797829__endTimestamp 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | ------- Summary: start ------- 04:33:17 INFO - PID 17928 | Number of tests: 6 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#0] dojo.html Cycles:165 Average:6169.15 Median:6400.58 stddev:857.95 (13.4%) stddev-sans-first:839.81 04:33:17 INFO - PID 17928 | Values: 3777.4 3856.9 3864.2 3885.0 3897.8 6031.1 6118.9 6136.4 6146.8 6216.3 6224.4 6265.8 6267.9 6288.6 6314.1 5579.5 5625.3 5656.3 5660.7 5674.5 275.4 5609.1 5651.3 5692.9 5697.9 5226.9 5531.9 5564.6 5602.9 5638.0 5515.1 5573.8 5651.9 5652.4 5652.6 5558.3 5564.3 5641.7 5642.6 5646.4 6045.6 6109.9 6115.2 6126.7 6208.7 6529.5 6644.6 6657.0 6739.1 6743.0 6659.0 6702.3 6758.9 6793.7 6838.0 6304.1 6346.6 6376.2 6387.0 6400.6 6907.3 6945.2 6951.3 7007.2 7036.0 6531.6 6648.9 6684.0 6768.2 6773.2 6705.5 6738.1 6777.7 6813.5 6831.4 6738.1 6781.1 6789.5 6795.2 6802.9 6703.3 6733.1 6734.8 6819.1 6821.7 4864.0 4931.1 4979.0 4980.1 4980.8 4506.4 4519.6 4578.2 4585.3 4597.1 6174.0 6176.1 6249.9 6256.7 6270.7 6507.4 6607.3 6682.0 6749.1 6761.6 6148.4 6164.3 6181.7 6192.1 6195.0 5431.9 5497.0 5497.4 5504.8 5511.7 6938.2 6943.0 6954.4 7027.8 7049.8 6702.4 6788.7 6796.0 6797.0 6800.4 6989.2 6989.7 7042.4 7077.4 7102.4 6589.2 6603.2 6679.3 6688.9 6729.3 6675.6 6737.6 6739.6 6752.0 6752.7 6363.9 6480.6 6514.8 6528.2 6536.8 6415.0 6426.6 6493.8 6513.4 6514.9 6289.5 6302.2 6327.3 6410.7 6422.1 6519.5 6538.8 6602.5 6609.6 6612.4 6352.9 6356.7 6356.7 6388.5 6404.3 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#1] ext.html Cycles:180 Average:44541.93 Median:20866.35 stddev:67708.52 (324.5%) stddev-sans-first:67819.38 04:33:17 INFO - PID 17928 | Values: 956.9 964.7 987.4 1016.3 1018.0 44758.3 45802.8 45876.5 46007.8 46014.8 45653.8 47076.0 47095.5 47238.8 47369.0 8454.6 8547.0 8554.1 8555.8 8560.7 8361.6 8487.3 8488.8 8490.1 8490.6 8488.5 8489.7 8552.3 8556.8 8585.7 8484.2 8488.9 8512.3 8519.3 8521.3 8018.5 8020.8 8045.0 8053.5 8058.1 42467.6 42992.4 43026.4 43323.0 43366.3 3768.6 3778.5 3791.6 3806.7 3814.6 33947.5 34044.7 34049.0 34064.7 34108.8 5174.5 5396.6 5422.4 5456.3 5494.3 241102.0 241489.0 243161.0 243433.0 243710.0 54858.5 55100.4 55555.8 55602.4 55902.0 58356.4 58638.7 58675.4 58776.4 58782.7 16549.3 16645.1 16654.1 16656.6 17855.8 14365.0 14411.3 14413.6 14420.4 14422.4 16190.8 16256.8 16288.1 16291.0 16337.6 6258.6 6279.9 6291.3 6423.3 6523.8 1115.9 1115.9 1119.8 1121.9 1129.6 25672.7 26196.3 26239.5 26365.9 26530.2 1202.8 1227.1 1238.3 1253.9 1259.8 13559.1 13699.9 13918.9 13994.8 14215.5 292234.0 293660.0 293846.0 294907.0 295175.0 51419.2 52159.0 59381.1 59684.7 60560.7 1560.6 1591.0 1591.2 1595.4 1599.1 31468.0 31576.5 32200.0 32468.4 32470.0 42775.1 42823.4 42855.0 42895.0 43016.1 240241.0 241698.0 241847.0 241962.0 242013.0 37926.0 38763.6 38836.2 39400.2 39591.4 48784.5 48980.5 49132.5 49445.3 49521.8 33993.5 34568.5 35265.5 35339.3 36300.3 34679.3 34803.0 34838.3 35456.0 35515.1 40288.0 41259.6 41505.2 41723.8 42161.4 33589.2 33899.7 34179.5 34436.3 34680.1 26185.5 26189.2 26210.2 26218.0 26234.7 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#2] jquery.html Cycles:180 Average:40425.16 Median:21010.84 stddev:102991.76 (490.2%) stddev-sans-first:103237.30 04:33:17 INFO - PID 17928 | Values: 613.7 637.1 637.2 638.6 641.7 23012.1 23317.2 23675.9 23905.0 23998.8 26183.2 26599.3 26653.6 26682.9 26774.3 6475.6 6671.9 6680.7 6681.8 6686.5 6125.8 6645.4 6914.9 6928.8 6934.0 6827.0 6862.2 6869.1 6870.1 6870.6 6511.6 6767.6 6804.7 6840.8 6841.4 6293.5 6327.9 6377.2 6382.9 6389.0 29433.4 29871.6 29932.3 29986.7 30052.0 2243.1 2254.1 2256.4 2264.7 2266.7 19425.7 20847.0 20865.9 20919.3 20991.9 2517.1 2530.8 2578.0 2675.4 2678.2 143436.0 148335.0 166352.0 170957.1 171969.0 16476.5 16485.4 16861.3 16901.2 17212.4 26976.3 27051.6 27102.6 27131.2 27142.0 11193.2 11260.9 11368.9 11402.1 11417.4 10312.9 10359.2 10364.2 10401.8 10415.3 10149.3 10304.2 10352.5 10426.8 10472.5 3097.5 3098.5 3132.0 3142.4 3274.6 1023.6 1040.5 1045.0 1051.1 1057.3 20730.5 21029.8 21105.2 21131.7 21630.1 1088.0 1100.3 1114.4 1124.3 1126.3 11369.6 11386.7 11570.0 11598.5 11693.4 598060.0 609289.0 615262.0 619895.0 623138.0 133891.0 137097.0 137745.3 139021.0 142065.0 1219.4 1232.5 1256.1 1260.9 1265.8 18190.9 18556.9 18829.5 19031.2 19041.1 61966.7 62543.4 63176.4 64526.0 64871.7 77355.2 77496.6 78243.2 79152.2 80065.0 15623.2 15792.4 15862.8 15901.1 15911.1 23079.7 23452.3 23789.6 23943.0 24220.8 17310.8 17342.0 17552.6 18930.6 19631.5 17256.4 17450.5 17534.3 17985.8 18085.0 17302.5 17386.2 19424.7 20108.4 20369.5 15261.8 15440.4 15460.3 15524.5 15566.1 18903.1 19030.8 19158.9 19304.4 19394.1 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#3] mootools.html Cycles:180 Average:10837.85 Median:14265.24 stddev:8009.59 (56.1%) stddev-sans-first:8000.59 04:33:17 INFO - PID 17928 | Values: 1386.8 1463.4 1468.9 1472.0 1475.8 16547.6 17129.9 18084.8 18119.9 18144.9 17564.4 17825.6 17837.0 17867.6 17920.7 2393.8 2823.3 2825.7 2831.4 2833.8 2828.0 2837.2 2872.3 2873.3 2875.4 2819.1 2822.9 2878.4 2891.3 2898.5 2796.0 2831.7 2837.6 2842.4 2847.8 2819.0 2824.9 2829.3 2837.5 2842.6 16681.8 16807.5 17061.0 17075.3 17083.1 8647.6 8943.5 8967.7 8995.5 9004.7 5530.6 5703.7 5710.9 5765.1 5849.4 2123.1 2135.6 2143.3 2207.8 2209.1 30783.4 31033.7 31213.5 31321.2 31444.4 8007.1 8161.6 8172.0 8361.0 8363.5 23685.6 23715.1 23764.6 23793.6 23832.8 7863.9 8852.6 9028.4 9031.2 9049.2 6636.5 7188.1 7838.7 8139.8 8212.6 6101.3 6231.0 6243.8 6320.4 6342.5 1893.3 1966.4 1970.4 1973.6 2004.4 1023.7 1040.2 1043.1 1053.9 1064.3 8899.6 8902.6 8915.2 8939.8 9005.7 814.6 823.1 839.0 841.5 848.8 5312.6 6232.5 6259.6 6290.6 6298.4 24255.8 25412.7 25512.6 25576.7 25734.5 23676.8 25398.6 25451.6 25462.0 25475.7 12598.6 12881.3 13137.1 13201.2 13201.2 9649.3 9723.5 9771.6 9796.0 9875.2 21651.8 21758.0 21851.8 22343.9 22951.5 21796.1 21883.0 22291.2 22310.4 22371.0 14152.1 14211.7 14275.2 14291.6 14339.3 15737.2 15917.4 15918.6 15926.6 15938.4 12175.6 12520.4 12611.3 12729.1 12737.8 11965.0 12227.3 12484.9 12486.3 12619.8 10787.4 11061.2 11070.9 11088.6 11090.6 8567.7 8655.4 8667.0 8778.0 8839.3 8476.3 8674.5 8696.5 8749.3 8785.3 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#4] prototype.html Cycles:180 Average:5652.02 Median:6223.38 stddev:1552.00 (24.9%) stddev-sans-first:1508.34 04:33:17 INFO - PID 17928 | Values: 548.4 568.1 568.9 579.7 581.9 6327.7 6333.4 6338.3 6360.4 6386.8 6233.4 6234.8 6266.8 6269.6 6279.6 5157.2 5168.9 5170.3 5170.7 5176.7 4955.8 5135.6 5143.7 5192.9 5197.5 5027.5 5038.4 5052.8 5060.3 5063.2 5040.8 5043.4 5043.7 5062.4 5076.2 4483.8 4568.6 4599.3 4627.1 4630.9 6089.8 6140.5 6141.5 6191.1 6213.4 5888.5 5908.5 5916.2 5931.6 5997.4 6738.7 6742.3 6753.4 6762.7 6787.8 5210.3 5218.0 5218.1 5220.8 5240.0 6618.9 6709.0 6889.9 6947.8 6959.4 5242.6 5247.4 5259.9 5317.9 5347.4 5378.9 5393.5 5404.8 5413.0 5445.5 5857.6 5927.0 5935.5 5940.3 5954.0 6652.4 6683.4 6687.0 6693.9 6704.7 1822.6 1863.2 1872.4 1873.3 1876.9 1285.4 1326.4 1335.5 1339.6 1352.6 6008.4 6042.1 6060.5 6073.6 6186.3 6511.3 6584.2 6589.8 6606.3 6699.0 6070.2 6085.2 6101.9 6122.9 6157.4 3489.7 3494.7 3522.9 3524.8 3531.0 6904.0 6921.3 6956.4 7042.5 7101.1 6785.3 6798.4 6878.6 6931.0 6956.2 6940.5 6946.9 7016.0 7042.5 7043.3 6627.5 6642.8 6676.1 6688.7 6707.4 6594.3 6604.8 6682.0 6704.7 6710.4 6816.7 6818.4 6939.4 6950.9 6969.4 5244.3 5274.1 5312.1 5326.5 5338.8 6618.0 6748.4 6779.8 6800.8 6802.4 6022.3 6492.4 6531.1 6555.7 6580.4 6458.2 6460.8 6495.6 6556.5 6631.2 6453.5 6459.4 6471.7 6523.3 6535.5 6602.4 6623.0 6627.3 6688.9 6702.7 6358.7 6427.2 6443.0 6455.6 6466.4 04:33:17 INFO - PID 17928 | 04:33:17 INFO - PID 17928 | [#5] yui.html Cycles:180 Average:29246.31 Median:18217.27 stddev:45119.07 (247.7%) stddev-sans-first:45195.66 04:33:17 INFO - PID 17928 | Values: 960.4 970.2 995.8 996.2 1000.7 18814.0 19127.9 19131.2 19133.7 19180.0 19090.7 19545.8 19623.5 19784.7 19897.0 1028.8 1056.8 1057.8 1058.8 1059.0 1045.5 1078.2 1081.2 1081.9 1085.6 1136.3 1142.9 1144.1 1144.6 1144.9 1095.1 1126.5 1136.3 1139.0 1146.2 797.6 812.4 815.2 815.6 817.3 20609.7 20753.4 20860.2 20923.1 20960.8 21519.2 21690.7 22075.6 22260.7 22369.3 18311.2 18949.0 18992.1 19044.0 19171.3 3916.0 3953.9 3955.6 3959.7 3962.6 165296.0 165934.0 166430.0 167284.2 170405.1 17811.8 17915.0 17934.4 18053.7 18123.4 32523.8 34621.8 34883.0 34970.3 35129.6 9826.7 9864.5 9874.3 9889.9 9894.7 4814.3 4831.3 4885.3 4907.3 4929.0 6076.2 6157.2 6160.2 6166.9 6172.3 1133.2 1150.4 1166.1 1176.2 1180.0 719.2 727.8 740.0 740.9 761.8 12904.2 13306.4 13746.5 14049.9 14259.7 709.4 718.9 721.2 733.1 739.6 6344.5 6388.6 6436.8 6445.8 6464.4 158067.2 158186.0 158704.0 163965.0 166177.0 139266.0 139421.6 140524.0 140824.0 144897.0 120812.0 122246.4 124099.4 124822.0 125099.4 11900.5 12012.8 12041.2 12169.9 12256.4 57693.7 57714.3 57847.4 58622.4 59125.7 72425.3 73309.3 73881.0 73939.6 76394.6 15675.3 15762.3 15823.1 15894.5 15941.4 19470.1 19594.0 19962.6 19968.5 20091.0 15017.6 15075.9 15356.7 15476.7 15595.8 16699.7 16736.8 16912.3 16965.5 17077.7 15612.7 15614.6 15692.2 15782.6 15931.7 12517.3 12561.4 12565.6 12622.1 12632.6 13302.3 13445.0 13513.3 13589.8 13641.0 04:33:17 INFO - PID 17928 | -------- Summary: end -------- 04:33:17 INFO - PID 17928 | 04:33:18 INFO - TEST-INFO | 17928: exit 0 04:33:18 INFO - TEST-OK | dromaeo_css | took 1107578ms 04:33:18 INFO - TEST-START | kraken 04:33:18 INFO - Initialising browser for kraken test... 04:33:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45096/getInfo.html -profile /tmp/tmppf62C5/profile 04:33:18 INFO - TEST-INFO | started process 18294 (/builds/slave/test/build/application/firefox/firefox http://localhost:45096/getInfo.html) 04:33:23 INFO - TEST-INFO | 18294: exit 0 04:33:23 INFO - Browser initialized. 04:33:23 INFO - Running cycle 1/1 for kraken test... 04:33:23 INFO - Using env: {'DISPLAY': ':0', 04:33:23 INFO - 'HOME': '/home/cltbld', 04:33:23 INFO - 'JSGC_DISABLE_POISONING': '1', 04:33:23 INFO - 'LANG': 'en_US.UTF-8', 04:33:23 INFO - 'LANGUAGE': 'en_US:en', 04:33:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:33:23 INFO - 'LOGNAME': 'cltbld', 04:33:23 INFO - 'MAIL': '/var/mail/cltbld', 04:33:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:33:23 INFO - 'MOZ_CRASHREPORTER': '1', 04:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:33:23 INFO - 'MOZ_NO_REMOTE': '1', 04:33:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:23 INFO - 'NO_EM_RESTART': '1', 04:33:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:23 INFO - 'PWD': '/builds/slave/test', 04:33:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:23 INFO - 'RUST_BACKTRACE': 'full', 04:33:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:33:23 INFO - 'SHELL': '/bin/bash', 04:33:23 INFO - 'SHLVL': '1', 04:33:23 INFO - 'STYLO_FORCE_DISABLED': '1', 04:33:23 INFO - 'TERM': 'linux', 04:33:23 INFO - 'TMOUT': '86400', 04:33:23 INFO - 'USER': 'cltbld', 04:33:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377', 04:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:23 INFO - '_': '/tools/buildbot/bin/python'} 04:33:23 INFO - TEST-INFO | started process 18530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppf62C5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:24 INFO - PID 18530 | 04:33:24 INFO - PID 18530 | (/builds/slave/test/build/application/firefox/firefox:18580): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:33:24 INFO - PID 18530 | 04:33:35 INFO - PID 18530 | RSS: Main: 144936960 04:33:35 INFO - PID 18530 | 04:33:37 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45096/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:38 INFO - PID 18530 | RSS: Main: 150568960 04:33:38 INFO - PID 18530 | 04:33:41 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45096/tests/kraken/driver.html?testName=audio-dft) 04:33:41 INFO - PID 18530 | RSS: Main: 150982656 04:33:41 INFO - PID 18530 | 04:33:44 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45096/tests/kraken/driver.html?testName=audio-fft) 04:33:45 INFO - PID 18530 | RSS: Main: 147640320 04:33:45 INFO - PID 18530 | 04:33:47 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45096/tests/kraken/driver.html?testName=audio-oscillator) 04:33:47 INFO - PID 18530 | RSS: Main: 148488192 04:33:47 INFO - PID 18530 | 04:33:49 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:50 INFO - PID 18530 | RSS: Main: 148250624 04:33:50 INFO - PID 18530 | 04:33:53 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45096/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:54 INFO - PID 18530 | RSS: Main: 148172800 04:33:54 INFO - PID 18530 | 04:33:57 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45096/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:58 INFO - PID 18530 | RSS: Main: 150216704 04:33:58 INFO - PID 18530 | 04:34:01 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45096/tests/kraken/driver.html?testName=json-parse-financial) 04:34:01 INFO - PID 18530 | RSS: Main: 151195648 04:34:01 INFO - PID 18530 | 04:34:03 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:03 INFO - PID 18530 | RSS: Main: 151064576 04:34:03 INFO - PID 18530 | 04:34:05 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:06 INFO - PID 18530 | RSS: Main: 151150592 04:34:06 INFO - PID 18530 | 04:34:08 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:08 INFO - PID 18530 | RSS: Main: 148144128 04:34:08 INFO - PID 18530 | 04:34:11 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:11 INFO - PID 18530 | RSS: Main: 147968000 04:34:11 INFO - PID 18530 | 04:34:14 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:15 INFO - PID 18530 | RSS: Main: 148463616 04:34:15 INFO - PID 18530 | 04:34:16 INFO - PID 18530 | Cycle 1(1): loaded http://localhost:45096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45096/tests/kraken/driver.html?testName=ai-astar) 04:34:17 INFO - PID 18530 | RSS: Main: 149704704 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | __start_tp_report 04:34:17 INFO - PID 18530 | _x_x_mozilla_page_load 04:34:17 INFO - PID 18530 | _x_x_mozilla_page_load_details 04:34:17 INFO - PID 18530 | |i|pagename|runs| 04:34:17 INFO - PID 18530 | |0;ai-astar;107;107;107;106;105;116;98;105;106;106 04:34:17 INFO - PID 18530 | |1;audio-beat-detection;115;112;115;112;116;120;114;114;114;120 04:34:17 INFO - PID 18530 | |2;audio-dft;161;162;162;163;162;163;162;165;165;166 04:34:17 INFO - PID 18530 | |3;audio-fft;75;76;74;74;74;74;74;74;74;72 04:34:17 INFO - PID 18530 | |4;audio-oscillator;78;79;79;82;78;78;77;78;78;79 04:34:17 INFO - PID 18530 | |5;imaging-gaussian-blur;113;113;112;116;112;113;112;113;112;113 04:34:17 INFO - PID 18530 | |6;imaging-darkroom;160;150;153;149;150;150;149;150;149;150 04:34:17 INFO - PID 18530 | |7;imaging-desaturate;95;94;94;94;93;94;95;95;94;95 04:34:17 INFO - PID 18530 | |8;json-parse-financial;46;45;44;43;47;51;50;43;45;44 04:34:17 INFO - PID 18530 | |9;json-stringify-tinderbox;38;38;37;38;38;38;37;38;37;40 04:34:17 INFO - PID 18530 | |10;stanford-crypto-aes;71;72;70;77;71;71;72;73;82;78 04:34:17 INFO - PID 18530 | |11;stanford-crypto-ccm;111;108;112;103;107;110;106;105;102;108 04:34:17 INFO - PID 18530 | |12;stanford-crypto-pbkdf2;154;148;147;147;159;152;155;148;151;155 04:34:17 INFO - PID 18530 | |13;stanford-crypto-sha256-iterative;59;59;59;60;62;61;57;60;60;58 04:34:17 INFO - PID 18530 | __end_tp_report 04:34:17 INFO - PID 18530 | __start_cc_report 04:34:17 INFO - PID 18530 | _x_x_mozilla_cycle_collect,732 04:34:17 INFO - PID 18530 | __end_cc_report 04:34:17 INFO - PID 18530 | __startTimestamp1506684857025__endTimestamp 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | ------- Summary: start ------- 04:34:17 INFO - PID 18530 | Number of tests: 14 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.00 stddev:4.32 (4.0%) stddev-sans-first:4.58 04:34:17 INFO - PID 18530 | Values: 107.0 107.0 107.0 106.0 105.0 116.0 98.0 105.0 106.0 106.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#1] audio-beat-detection Cycles:10 Average:115.20 Median:115.00 stddev:2.82 (2.5%) stddev-sans-first:2.99 04:34:17 INFO - PID 18530 | Values: 115.0 112.0 115.0 112.0 116.0 120.0 114.0 114.0 114.0 120.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.66 (1.0%) stddev-sans-first:1.58 04:34:17 INFO - PID 18530 | Values: 161.0 162.0 162.0 163.0 162.0 163.0 162.0 165.0 165.0 166.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 04:34:17 INFO - PID 18530 | Values: 75.0 76.0 74.0 74.0 74.0 74.0 74.0 74.0 74.0 72.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:1.35 (1.7%) stddev-sans-first:1.41 04:34:17 INFO - PID 18530 | Values: 78.0 79.0 79.0 82.0 78.0 78.0 77.0 78.0 78.0 79.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 04:34:17 INFO - PID 18530 | Values: 113.0 113.0 112.0 116.0 112.0 113.0 112.0 113.0 112.0 113.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:150.00 stddev:3.37 (2.2%) stddev-sans-first:1.22 04:34:17 INFO - PID 18530 | Values: 160.0 150.0 153.0 149.0 150.0 150.0 149.0 150.0 149.0 150.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:34:17 INFO - PID 18530 | Values: 95.0 94.0 94.0 94.0 93.0 94.0 95.0 95.0 94.0 95.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:45.50 stddev:2.78 (6.1%) stddev-sans-first:2.95 04:34:17 INFO - PID 18530 | Values: 46.0 45.0 44.0 43.0 47.0 51.0 50.0 43.0 45.0 44.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.88 (2.3%) stddev-sans-first:0.93 04:34:17 INFO - PID 18530 | Values: 38.0 38.0 37.0 38.0 38.0 38.0 37.0 38.0 37.0 40.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:72.50 stddev:3.95 (5.4%) stddev-sans-first:4.06 04:34:17 INFO - PID 18530 | Values: 71.0 72.0 70.0 77.0 71.0 71.0 72.0 73.0 82.0 78.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:108.00 stddev:3.29 (3.0%) stddev-sans-first:3.19 04:34:17 INFO - PID 18530 | Values: 111.0 108.0 112.0 103.0 107.0 110.0 106.0 105.0 102.0 108.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:153.00 stddev:4.12 (2.7%) stddev-sans-first:4.27 04:34:17 INFO - PID 18530 | Values: 154.0 148.0 147.0 147.0 159.0 152.0 155.0 148.0 151.0 155.0 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.51 04:34:17 INFO - PID 18530 | Values: 59.0 59.0 59.0 60.0 62.0 61.0 57.0 60.0 60.0 58.0 04:34:17 INFO - PID 18530 | -------- Summary: end -------- 04:34:17 INFO - PID 18530 | 04:34:17 INFO - PID 18530 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:34:17 INFO - TEST-INFO | 18530: exit 0 04:34:17 INFO - TEST-OK | kraken | took 59340ms 04:34:17 INFO - SUITE-END | took 1166s 04:34:18 INFO - Completed test suite (00:19:27) 04:34:18 INFO - javascript benchmark 04:34:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9175.475858155312, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3777.414500752383, 3856.86500972466, 3864.246471937973, 3885.0093226227327, 3897.785621790801, 6031.125486804422, 6118.908216376747, 6136.447719705231, 6146.8463288417815, 6216.285127210373, 6224.439800417961, 6265.780697675571, 6267.874642507147, 6288.559800813945, 6314.052892066193, 5579.497845193931, 5625.324961004685, 5656.349519805223, 5660.745266462998, 5674.489295963363, 275.38451560761706, 5609.074502707049, 5651.2935883014625, 5692.857678558028, 5697.8575535611735, 5226.92159617606, 5531.889362212753, 5564.610477266593, 5602.943970560283, 5637.9718101409435, 5515.145152501369, 5573.804916827932, 5651.886962260773, 5652.434756524356, 5652.63257888236, 5558.333000039981, 5564.304461942257, 5641.746121424546, 5642.633228840113, 5646.350669672999, 6045.6070355426755, 6109.877802443971, 6115.205023346981, 6126.693665316717, 6208.689565521706, 6529.5429319947625, 6644.634545100018, 6657.0, 6739.090222819906, 6742.966285168592, 6658.966705166492, 6702.262751097375, 6758.932410675929, 6793.694283757193, 6838.008488769101, 6304.117423560705, 6346.587471814318, 6376.234851817811, 6387.0, 6400.583962042452, 6907.34380233882, 6945.236024037352, 6951.270116637781, 7007.159140903124, 7036.0, 6531.608103513804, 6648.933510664831, 6683.966580167068, 6768.187817461936, 6773.187217533928, 6705.463562914955, 6738.124043874265, 6777.661116944133, 6813.488988325896, 6831.385175334144, 6738.124043874363, 6781.050652908597, 6789.490788190906, 6795.2185498667295, 6802.897956530656, 6703.296153903867, 6733.091032710619, 6734.797956061326, 6819.147606549182, 6821.658917054127, 4864.0, 4931.112399768076, 4979.029089327546, 4980.103581355318, 4980.775865086008, 4506.3916371290115, 4519.570640789119, 4578.175928332866, 4585.335126406652, 4597.057603191338, 6174.041077088114, 6176.073588961692, 6249.875002499924, 6256.6871656417, 6270.749170033238, 6507.414332710079, 6607.273199948002, 6681.966590167115, 6749.0551322814845, 6761.628110453972, 6148.354422785633, 6164.260288765287, 6181.660008699475, 6192.071189321638, 6195.0, 5431.864203394868, 5497.038018346773, 5497.39528651848, 5504.752286147133, 5511.696856672921, 6938.236793952661, 6943.0, 6954.4436445084275, 7027.789166325018, 7049.8237544060785, 6702.430293425114, 6788.694508747119, 6796.0, 6797.0, 6800.387965083265, 6989.231184569795, 6989.720411183495, 7042.401395881408, 7077.433805295667, 7102.431805455654, 6589.209294884645, 6603.174603174603, 6679.298673639198, 6688.933110668831, 6729.259781424137, 6675.632840193836, 6737.629430381376, 6739.595624262364, 6751.966240168767, 6752.696128674123, 6363.886319894093, 6480.611163330215, 6514.837129071811, 6528.183977002875, 6536.803895883131, 6415.037744338387, 6426.550141490051, 6493.7727179550375, 6513.413792758674, 6514.9348506514325, 6289.528285378707, 6302.243730752339, 6327.335629758809, 6410.743570257137, 6422.068800024063, 6519.511036672174, 6538.803835884931, 6602.471802255904, 6609.570377925612, 6612.40488356031, 6352.936470635234, 6356.68216589178, 6356.745730170742, 6388.4569811566535, 6404.327545607644], "value": 6114.451141189976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.9138777510032, 964.7105868239531, 987.4223579206164, 1016.2936758952528, 1017.9796404071918, 44758.32862507061, 45802.77098614511, 45876.54123458768, 46007.76996115023, 46014.769926150366, 45653.7717311413, 47076.0, 47095.52904470954, 47238.76380618092, 47369.0, 8454.61954212062, 8547.0, 8554.059053504141, 8555.828883422328, 8560.657573697075, 8361.581920903931, 8487.321014318839, 8488.78778030548, 8490.066092729794, 8490.575471226444, 8488.490690558556, 8489.702860399888, 8552.315814734837, 8556.828863422728, 8585.699500517483, 8484.19400156984, 8488.872666910001, 8512.319014478826, 8519.318454523685, 8521.318294536422, 8018.478798878113, 8020.839583208362, 8045.0, 8053.516788992679, 8058.073321568036, 42467.575324246674, 42992.35511467331, 43026.35460468096, 43323.0, 43366.349504757454, 3768.6419790119894, 3778.4710140580064, 3791.639794219545, 3806.695464362844, 3814.618538146191, 33947.490787638206, 34044.65955340464, 34049.0, 34064.659353406394, 34108.82945585281, 5174.508421699932, 5396.64921780083, 5422.43064478232, 5456.290682211287, 5494.2582751328455, 241102.0, 241489.0, 243161.0, 243433.0, 243710.0, 54858.45141548533, 55100.448995510334, 55555.7777688896, 55602.443975560534, 55902.0, 58356.4164358351, 58638.70680646655, 58675.41324586785, 58776.41223587709, 58782.70608646929, 16549.338026478807, 16645.084520351254, 16654.08402537872, 16656.58358541022, 17855.821441785676, 14365.0, 14411.279436028157, 14413.639659008608, 14420.351084201237, 14422.350994205286, 16190.75713864293, 16256.837431625769, 16288.104154271628, 16291.0, 16337.591560211089, 6258.624482531062, 6279.874402511924, 6291.307956124822, 6423.325550817191, 6523.836904077341, 1115.866096068477, 1115.9051480624075, 1119.8152304869768, 1121.9382933938712, 1129.5707631100129, 25672.743272567408, 26196.34509137249, 26239.475210495682, 26365.9453621853, 26530.204093877215, 1202.7654607351483, 1227.1042139238407, 1238.3127364312713, 1253.9122261441794, 1259.7921342978489, 13559.118657287245, 13699.931500342434, 13918.860811391958, 13994.790078148835, 14215.502457414148, 292234.0, 293660.0, 293846.0, 294907.0, 295175.0, 51419.228711569354, 52159.0, 59381.10928336078, 59684.701576492705, 60560.697196513735, 1560.6410525578954, 1591.0, 1591.172590253062, 1595.4017243533674, 1599.1045014791755, 31468.0, 31576.526352104276, 32200.0, 32468.35063298768, 32470.0, 42775.144497109264, 42823.35764963466, 42855.0, 42895.0, 43016.139677206906, 240241.0, 241698.0, 241847.0, 241962.0, 242013.0, 37926.0, 38763.612363876004, 38836.22327553377, 39400.211995760495, 39591.40612890867, 48784.51215487942, 48980.51019489759, 49132.508674912795, 49445.280509572316, 49521.75239123782, 33993.490097648064, 34568.48147277743, 35265.47101793424, 35339.29321413609, 36300.27399452049, 34679.306413871076, 34803.0, 34838.303233934676, 35456.0, 35515.112122197155, 40288.0, 41259.587404125574, 41505.1698966025, 41723.7913810429, 42161.36757948695, 33589.16027099244, 33899.66100338965, 34179.4873076909, 34436.31127377489, 34680.13299667528, 26185.476290473704, 26189.214323570322, 26210.213693589223, 26218.0, 26234.73765262323], "value": 19338.379982495317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.6931534232883, 637.063516630553, 637.2083098946715, 638.6427385932388, 641.7070386934649, 23012.079516819307, 23317.183898563533, 23675.881620591917, 23905.043798248073, 23998.760012399893, 26183.214503564923, 26599.335016624595, 26653.600195997074, 26682.866585667045, 26774.33064173392, 6475.611463312192, 6671.899921501157, 6680.699368528403, 6681.832954176136, 6686.465082793365, 6125.754969801203, 6645.435138013275, 6914.861702765942, 6928.757493487729, 6933.965330173342, 6826.965865170667, 6862.176538815324, 6869.072675188835, 6870.072540207083, 6870.587764734107, 6511.641859697715, 6767.593944363305, 6804.65976701163, 6840.828979275509, 6841.418479429254, 6293.527985401113, 6327.905081423783, 6377.234731832164, 6382.936170638281, 6388.968055159741, 29433.41133177346, 29871.551926721117, 29932.251693707833, 29986.700132998827, 30052.0, 2243.091547923094, 2254.1434254983164, 2256.435891027243, 2264.671622614712, 2266.660000999847, 19425.708614370797, 20847.0, 20865.89567052155, 20919.26782562603, 20991.89504052485, 2517.0812653381568, 2530.772230499264, 2577.9613305800426, 2675.357914100621, 2678.1965410377, 143436.0, 148335.0, 166352.0, 170957.14521427313, 171969.0, 16476.505704828873, 16485.423010194587, 16861.31386861304, 16901.23944422504, 17212.39756608513, 26976.32559186036, 27051.594226086625, 27102.5934610981, 27131.186064417703, 27142.0, 11193.16051296156, 11260.94369528147, 11368.886311136948, 11402.144839137098, 11417.372044537464, 10312.948435257926, 10359.223058270509, 10364.170866330676, 10401.84397234042, 10415.270931034755, 10149.34029288094, 10304.227182961307, 10352.5341359639, 10426.791464170827, 10472.528736206888, 3097.4889143291102, 3098.4762247119006, 3131.9530207046914, 3142.447995928469, 3274.6397896231397, 1023.6007956896816, 1040.5317607076845, 1044.9582016719246, 1051.0855555666467, 1057.3391630231106, 20730.48173795667, 21029.789702102782, 21105.155793768383, 21131.683024754642, 21630.13479460804, 1088.0, 1100.3287994323457, 1114.4316398636754, 1124.2579897267929, 1126.2735535579668, 11369.602063927723, 11386.715332116763, 11570.0, 11598.478068486938, 11693.356865372316, 598060.0, 609289.0, 615262.0, 619895.0, 623138.0, 133891.0, 137097.0, 137745.311273443, 139021.0, 142065.0, 1219.359836086062, 1232.4700378837185, 1256.0579565326007, 1260.9054320925968, 1265.8038004109194, 18190.90904545469, 18556.907215463838, 18829.529261768566, 19031.238750449826, 19041.143148558625, 61966.69016654888, 62543.374566255574, 63176.36823631705, 64526.0, 64871.67564162149, 77355.2264477348, 77496.61251693705, 78243.2175678236, 79152.20847791448, 80065.0, 15623.218839057774, 15792.447264345692, 15862.841371586137, 15901.125438100553, 15911.124888131264, 23079.653805193273, 23452.296431107094, 23789.64315535303, 23943.0, 24220.75779242185, 17310.82689173092, 17342.0, 17552.648947020734, 18930.621387571897, 19631.509212269808, 17256.396026139024, 17450.47648570545, 17534.298628054734, 17985.820141798413, 18085.0, 17302.480925572254, 17386.21762020687, 19424.70862937029, 20108.39674809758, 20369.49076273105, 15261.771073433685, 15440.382384704486, 15460.304286307368, 15524.534263972098, 15566.143862087694, 18903.149358278635, 19030.809691903458, 19158.90420547944, 19304.420867374, 19394.127264272858], "value": 12908.613182353385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.8405133409656, 1463.3707505772527, 1468.897177197596, 1471.9916856952984, 1475.8007668964688, 16547.58631034225, 17129.914350428247, 18084.81915180848, 18119.909400453012, 18144.909275453603, 17564.385246516373, 17825.643487130248, 17837.0, 17867.553311167227, 17920.731189032176, 2393.7845593896545, 2823.294176455881, 2825.66092068951, 2831.362943337753, 2833.7874659400522, 2827.971720282802, 2837.1914004508717, 2872.3250036241466, 2873.281679580105, 2875.3674191677796, 2819.0556163685087, 2822.887084516617, 2878.409925965172, 2891.277180704824, 2898.4637841999297, 2795.9860200699068, 2831.730985556369, 2837.6311079559628, 2842.4457230839994, 2847.829130252181, 2818.9859050704617, 2824.8728807203725, 2829.2502486841004, 2837.5459926411677, 2842.616246806696, 16681.83318166815, 16807.495775126765, 17061.0, 17075.316987320493, 17083.06043167625, 8647.610857511427, 8943.463392196489, 8967.68613098545, 8995.460272383678, 9004.729858104267, 5530.6128571000045, 5703.7148142592705, 5710.857228569277, 5765.077587586008, 5849.444302791228, 2123.1189056541516, 2135.6187850546685, 2143.3034263864306, 2207.7902599253043, 2209.0501084533644, 30783.384332313453, 31033.68966310353, 31213.531797022835, 31321.216969575715, 31444.37111257785, 8007.119216886138, 8161.551114688749, 8171.959140204261, 8360.958195208985, 8363.540005299645, 23685.644715329283, 23715.051397943887, 23764.64353034671, 23793.620637936066, 23832.7616723834, 7863.882041769378, 8852.557372131369, 9028.368014239071, 9031.232345250728, 9049.230815380635, 6636.502262330345, 7188.137423509213, 7838.725644602526, 8139.79650508742, 8212.63043163059, 6101.267847858286, 6230.968845155745, 6243.75024999004, 6320.399562041599, 6342.4926005919415, 1893.3089422361015, 1966.3904189701238, 1970.359633119242, 1973.6052789441883, 2004.418718571598, 1023.698009087321, 1040.1834559870465, 1043.0612448795991, 1053.89461053894, 1064.2550214849637, 8899.644014239488, 8902.643894244158, 8915.153060459246, 8939.776505587412, 9005.729828105168, 814.5519964019766, 823.115151212437, 838.9538575378413, 841.54556539468, 848.7793173774863, 5312.628116031918, 6232.470240029557, 6259.593126446766, 6290.622562646256, 6298.370162983757, 24255.75744242535, 25412.745872541407, 25512.617310740352, 25576.744232557437, 25734.48531029369, 23676.763232367455, 25398.619020714705, 25451.61822572663, 25462.0, 25475.74524254734, 12598.56684556098, 12881.291528965998, 13137.146085504412, 13201.207927524187, 13201.20792752438, 9649.276304277348, 9723.46520941355, 9771.560279787285, 9795.951020244853, 9875.209983201183, 21651.783482165607, 21758.0, 21851.781482184975, 22343.888280558494, 22951.54096918019, 21796.128154873626, 21883.0, 22291.219807306665, 22310.442238944157, 22371.0, 14152.080114792505, 14211.715765684421, 14275.214863182624, 14291.64270893236, 14339.283035848375, 15737.213139342759, 15917.363305467652, 15918.60203494922, 15926.601834953755, 15938.36246550125, 12175.573854915036, 12520.373981301082, 12611.306378148924, 12729.108962372546, 12737.80893286583, 11965.0, 12227.266364018187, 12484.937575312066, 12486.250824950532, 12619.81070283928, 10787.406692631981, 11061.225714199929, 11070.889291106985, 11088.5564577416, 11090.5563777448, 8567.657293708182, 8655.394122411622, 8666.956665216885, 8777.990531089006, 8839.337049721167, 8476.321894248322, 8674.522901240493, 8696.478211307089, 8749.343799214957, 8785.253253473526], "value": 7555.6261812829625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3693752184987, 568.1421054208146, 568.9146628005801, 579.7246308003697, 581.874896897167, 6327.746890124389, 6333.366663333664, 6338.271098823637, 6360.427561519462, 6386.808395748123, 6233.376662333764, 6234.812955611327, 6266.811995640127, 6269.561130720851, 6279.591826531284, 5157.174852023677, 5168.8707782305555, 5170.276161337416, 5170.715610641413, 5176.689398636075, 4955.826546070888, 5135.589152867761, 5143.736755827424, 5192.922106168392, 5197.48025197481, 5027.472115427882, 5038.420581633104, 5052.797888084472, 5060.291559181699, 5063.215201643751, 5040.798368065273, 5043.360907704974, 5043.722595257259, 5062.417821950467, 5076.162433198518, 4483.753393563353, 4568.588827005586, 4599.2871104978785, 4627.120847039052, 4630.884227894296, 6089.756409743605, 6140.478059364959, 6141.508679305645, 6191.133241346215, 6213.378662133796, 5888.499477544414, 5908.5228692826795, 5916.171735956969, 5931.555133364972, 5997.430244126801, 6738.730450781963, 6742.258351581322, 6753.358430949052, 6762.661866906635, 6787.830304242384, 5210.270562121306, 5217.973910130463, 5218.086834803932, 5220.765065572058, 5240.0, 6618.93381066188, 6709.0, 6889.931100688979, 6947.818870791927, 6959.3736563709, 5242.633015688942, 5247.425772268304, 5259.894802103937, 5317.8936421271355, 5347.385050719139, 5378.870437208152, 5393.465071416428, 5404.83785486436, 5412.972935135378, 5445.455454454523, 5857.58996870215, 5926.970365148233, 5935.465808077293, 5940.34656187819, 5953.970230148908, 6652.368025037614, 6683.398494135551, 6687.030380594787, 6693.899591506131, 6704.659068186383, 1822.5874946916247, 1863.2174486715612, 1872.4008317338594, 1873.2881505028001, 1876.9155388007573, 1285.4408332375447, 1326.4230059923964, 1335.485837952376, 1339.564641491519, 1352.60774375432, 6008.394963022151, 6042.123892035718, 6060.454559089703, 6073.605215660968, 6186.257649082139, 6511.28375878653, 6584.209894812558, 6589.769358072444, 6606.306337834554, 6699.0, 6070.2412198475195, 6085.208922840003, 6101.938980610226, 6122.948812147892, 6157.445829875243, 3489.7382696297877, 3494.650534946536, 3522.9119272018406, 3524.788512689247, 3530.9646903531147, 6904.0, 6921.342472465108, 6956.365254165267, 7042.542234754725, 7101.147862256562, 6785.287544807823, 6798.422134118655, 6878.58728476283, 6930.965345173242, 6956.200036995709, 6940.548864323803, 6946.93053069473, 7015.964920175468, 7042.507024508235, 7043.295670432915, 6627.502937279627, 6642.833929151617, 6676.132102826601, 6688.7324507019175, 6707.396334329934, 6594.274629790815, 6604.8348791280605, 6682.0, 6704.66476676174, 6710.396064354231, 6816.727330906709, 6818.352256535622, 6939.444844412334, 6950.8609827804175, 6969.442444604318, 5244.318238629106, 5274.077036518671, 5312.123499622519, 5326.547243484347, 5338.839834804962, 6618.0, 6748.426383757435, 6779.847425937701, 6800.82997925036, 6802.387785099365, 6022.307434645072, 6492.38322359394, 6531.11829902957, 6555.737770489127, 6580.374864387875, 6458.22501299847, 6460.806175814733, 6495.610263384023, 6556.475481961336, 6631.237407697983, 6453.515986300952, 6459.386358295955, 6471.676416179266, 6523.347665233438, 6535.496835727714, 6602.40578347951, 6623.039659249478, 6627.304133065959, 6688.8929987053925, 6702.726481968411, 6358.745650173942, 6427.196600424947, 6443.0335449682925, 6455.61266324022, 6466.371968731899], "value": 5208.859817190787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.433344326847, 970.2383628851351, 995.7859060302034, 996.2080146283704, 1000.7448100734312, 18814.0, 19127.904360478176, 19131.234750609994, 19133.712994305097, 19180.0409979501, 19090.713639295423, 19545.804541954578, 19623.509412264666, 19784.70322945157, 19897.0, 1028.8250997330454, 1056.7939251845894, 1057.7567159553307, 1058.7776566920957, 1058.9947050264739, 1045.5190612318343, 1078.1698092468835, 1081.1512962324578, 1081.8809930907594, 1085.592902661502, 1136.2727854173336, 1142.8799976002483, 1144.1247445704043, 1144.622274649368, 1144.914131440141, 1095.1239008792934, 1126.5268587193316, 1136.318209074557, 1139.0432037088844, 1146.1633007904236, 797.5852556670499, 812.4110020235341, 815.229608020421, 815.5514467043103, 817.3297895725508, 20609.690854637192, 20753.377398678065, 20860.165593376245, 20923.05846236923, 20960.790392096038, 21519.246826361003, 21690.674639880413, 22075.558488830135, 22260.666090008664, 22369.328920132422, 18311.175997080165, 18949.0, 18992.14535345899, 19044.0477976102, 19171.32900348481, 3916.020994751312, 3953.9011524711823, 3955.564887862333, 3959.663428608572, 3962.643362097396, 165296.0, 165934.0, 166430.0, 167284.16357918255, 170405.1479742606, 17811.821881781274, 17915.0, 17934.372296969545, 18053.7291940621, 18123.36568220106, 32523.837380812944, 34621.826890865384, 34883.0, 34970.30059398849, 35129.64870351315, 9826.705198844045, 9864.506774661239, 9874.259430542594, 9889.851652225223, 9894.703158905244, 4814.301926220678, 4831.251156070814, 4885.316055752198, 4907.312976183337, 4929.038837426668, 6076.179715738407, 6157.230346206724, 6160.199174107337, 6166.907496387557, 6172.290186628506, 1133.1954312438097, 1150.4075401168404, 1166.125405945541, 1176.2413243458093, 1180.0205829161775, 719.2196466833544, 727.7743899391205, 739.9704011839466, 740.8925705772633, 761.8362052158701, 12904.16122952005, 13306.401211945486, 13746.518871839438, 14049.859501404855, 14259.714805704036, 709.4359983812881, 718.9173245076884, 721.2354903801987, 733.069002366991, 739.5599618227146, 6344.460720838688, 6388.584741991848, 6436.806895793134, 6445.806625801233, 6464.353564643498, 158067.20966395325, 158186.0, 158704.0, 163965.0, 166177.0, 139266.0, 139421.60578394087, 140524.0, 140824.0, 144897.0, 120812.0, 122246.38876805559, 124099.37950310191, 124822.0, 125099.37450312873, 11900.464479098287, 12012.75974480488, 12041.157119001586, 12169.878301216875, 12256.448459819152, 57693.71153144207, 57714.33131821087, 57847.4215257842, 58622.41377586169, 59125.70437147787, 72425.27574724186, 73309.26690733024, 73881.04475821122, 73939.63030184814, 76394.61802691173, 15675.294611742727, 15762.290696918437, 15823.129727865078, 15894.52316430509, 15941.36234550605, 19470.12384442675, 19594.0, 19962.60074798525, 19968.50078748043, 20091.0, 15017.624559385666, 15075.924620376827, 15356.692866142837, 15476.690466190837, 15595.844041559893, 16699.66600668004, 16736.832631674013, 16912.32350705958, 16965.491035268962, 17077.74383384275, 15612.687746244785, 15614.609634759221, 15692.215389230721, 15782.605434864221, 15931.681366372839, 12517.311547864954, 12561.43473543711, 12565.623031309075, 12622.116451848282, 12632.557860474839, 13302.334883255606, 13445.0, 13513.324333783468, 13589.796153057514, 13641.0], "value": 9932.843302029713, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1371.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 106.0, 105.0, 116.0, 98.0, 105.0, 106.0, 106.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 115.0, 112.0, 116.0, 120.0, 114.0, 114.0, 114.0, 120.0], "value": 115.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 165.0, 165.0, 166.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 72.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 82.0, 78.0, 78.0, 77.0, 78.0, 78.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 116.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 153.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 44.0, 43.0, 47.0, 51.0, 50.0, 43.0, 45.0, 44.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 40.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 77.0, 71.0, 71.0, 72.0, 73.0, 82.0, 78.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 112.0, 103.0, 107.0, 110.0, 106.0, 105.0, 102.0, 108.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 148.0, 147.0, 147.0, 159.0, 152.0, 155.0, 148.0, 151.0, 155.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 62.0, 61.0, 57.0, 60.0, 60.0, 58.0], "value": 59.5, "unit": "score"}]}]} 04:34:18 INFO - Return code: 0 04:34:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:18 INFO - # TBPL SUCCESS # 04:34:18 INFO - Running post-action listener: _package_coverage_data 04:34:18 INFO - Running post-action listener: _resource_record_post_action 04:34:18 INFO - [mozharness: 2017-09-29 11:34:18.315030Z] Finished run-tests step (success) 04:34:18 INFO - Running post-run listener: _resource_record_post_run 04:34:18 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 20480; Write bytes: 320561152; Read time: 216; Write time: 214736 04:34:18 INFO - TinderboxPrint: CPU usage
13.1% 04:34:18 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 216 04:34:18 INFO - TinderboxPrint: I/O write bytes / time
320,561,152 / 214,736 04:34:18 INFO - TinderboxPrint: CPU idle
8,212.2 (86.9%) 04:34:18 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 04:34:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 8097792; Read time: 0; Write time: 1240 04:34:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:34:18 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 12288; Write bytes: 311914496; Read time: 200; Write time: 213408 04:34:18 INFO - Running post-run listener: _upload_blobber_files 04:34:18 INFO - Blob upload gear active. 04:34:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:20 INFO - (blobuploader) - INFO - Done attempting. 04:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:21 INFO - (blobuploader) - INFO - Done attempting. 04:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:24 INFO - (blobuploader) - INFO - Done attempting. 04:34:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:34:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:26 INFO - (blobuploader) - INFO - Done attempting. 04:34:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:26 INFO - Return code: 0 04:34:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/069a54c3fc7e02d256475c80256dd46494b53909dc104de6b91d1ad8cb60e30833de4ac5def4a3fffea4caacbc13119d4fd479c423986856601a17a3f6eb0629", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57232953aaf4f1d5e98cd75bf88fa9150aa8dadcab691af3a05b94b95c0636d7cbb4b1258ca010ce0e71a194233ec8fa79947efb25270cc90a481fd574916f6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9d9eef75d9967c9c382508f1bf89e6317f84d6d811f633fe0cb4d95051f9f6c528364a328ce57c45cb6d32f2a75b7def449fd5c6ef66ae636b1e0f8697be2b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/410c8cadb7534bb9072ca2c7fb7f51937c35ec8b9ae6a4cd6fb43165e400d1d10e3c1fa5a811508609defc2c7e0090fff43b9e8a9378f2cee5397a9b2458900c"} 04:34:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:26 INFO - Contents: 04:34:26 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/069a54c3fc7e02d256475c80256dd46494b53909dc104de6b91d1ad8cb60e30833de4ac5def4a3fffea4caacbc13119d4fd479c423986856601a17a3f6eb0629", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57232953aaf4f1d5e98cd75bf88fa9150aa8dadcab691af3a05b94b95c0636d7cbb4b1258ca010ce0e71a194233ec8fa79947efb25270cc90a481fd574916f6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9d9eef75d9967c9c382508f1bf89e6317f84d6d811f633fe0cb4d95051f9f6c528364a328ce57c45cb6d32f2a75b7def449fd5c6ef66ae636b1e0f8697be2b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/410c8cadb7534bb9072ca2c7fb7f51937c35ec8b9ae6a4cd6fb43165e400d1d10e3c1fa5a811508609defc2c7e0090fff43b9e8a9378f2cee5397a9b2458900c"} 04:34:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:26 INFO - Copying logs to upload dir... 04:34:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.681492 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-29 04:34:26.102349) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:26.108050) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 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/sha512/069a54c3fc7e02d256475c80256dd46494b53909dc104de6b91d1ad8cb60e30833de4ac5def4a3fffea4caacbc13119d4fd479c423986856601a17a3f6eb0629", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57232953aaf4f1d5e98cd75bf88fa9150aa8dadcab691af3a05b94b95c0636d7cbb4b1258ca010ce0e71a194233ec8fa79947efb25270cc90a481fd574916f6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9d9eef75d9967c9c382508f1bf89e6317f84d6d811f633fe0cb4d95051f9f6c528364a328ce57c45cb6d32f2a75b7def449fd5c6ef66ae636b1e0f8697be2b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/410c8cadb7534bb9072ca2c7fb7f51937c35ec8b9ae6a4cd6fb43165e400d1d10e3c1fa5a811508609defc2c7e0090fff43b9e8a9378f2cee5397a9b2458900c"} build_url:https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011514 build_url: 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/069a54c3fc7e02d256475c80256dd46494b53909dc104de6b91d1ad8cb60e30833de4ac5def4a3fffea4caacbc13119d4fd479c423986856601a17a3f6eb0629", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57232953aaf4f1d5e98cd75bf88fa9150aa8dadcab691af3a05b94b95c0636d7cbb4b1258ca010ce0e71a194233ec8fa79947efb25270cc90a481fd574916f6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9d9eef75d9967c9c382508f1bf89e6317f84d6d811f633fe0cb4d95051f9f6c528364a328ce57c45cb6d32f2a75b7def449fd5c6ef66ae636b1e0f8697be2b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/410c8cadb7534bb9072ca2c7fb7f51937c35ec8b9ae6a4cd6fb43165e400d1d10e3c1fa5a811508609defc2c7e0090fff43b9e8a9378f2cee5397a9b2458900c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:26.137570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:26.137902) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1506683177.757987-255054377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:26.219883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:34:26.220209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:34:26.220555) ========= ========= Total master_lag: 0.19 =========