builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-006 starttime: 1505125106.42 results: success (0) revision: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.421029) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.421718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.422176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.440514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.440816) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 03:18:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.0M=0s 2017-09-11 03:18:26 (41.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.580912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.581415) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.631431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:26.631818) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9a5e9ed62103c84e4cde915f4d08f1ce71be83e --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 f9a5e9ed62103c84e4cde915f4d08f1ce71be83e --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=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 03:18:26,680 truncating revision to first 12 chars 2017-09-11 03:18:26,680 Setting DEBUG logging. 2017-09-11 03:18:26,680 attempt 1/10 2017-09-11 03:18:26,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9a5e9ed6210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 03:18:27,357 unpacking tar archive at: mozilla-central-f9a5e9ed6210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.955777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:27.604147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:27.604488) ========= script_repo_revision: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:27.604897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:27.605170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:27.618599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-11 03:18:27.619009) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:27 INFO - MultiFileLogger online at 20170911 03:18:27 in /builds/slave/test 03:18:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:18:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:27 INFO - {'append_to_log': False, 03:18:27 INFO - 'base_work_dir': '/builds/slave/test', 03:18:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:18:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:27 INFO - 'branch': 'Firefox-Non-PGO', 03:18:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:27 INFO - 'code_coverage': False, 03:18:27 INFO - 'config_files': ('talos/linux_config.py',), 03:18:27 INFO - 'default_actions': ('clobber', 03:18:27 INFO - 'read-buildbot-config', 03:18:27 INFO - 'download-and-extract', 03:18:27 INFO - 'populate-webroot', 03:18:27 INFO - 'create-virtualenv', 03:18:27 INFO - 'install', 03:18:27 INFO - 'setup-mitmproxy', 03:18:27 INFO - 'run-tests'), 03:18:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:27 INFO - 'disable_ccov_upload': False, 03:18:27 INFO - 'disable_stylo': False, 03:18:27 INFO - 'download_minidump_stackwalk': True, 03:18:27 INFO - 'download_symbols': 'ondemand', 03:18:27 INFO - 'enable_stylo': False, 03:18:27 INFO - 'enable_webrender': False, 03:18:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:18:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:27 INFO - 'gecko_profile': False, 03:18:27 INFO - 'gecko_profile_interval': 0, 03:18:27 INFO - 'installer_path': 'installer.exe', 03:18:27 INFO - 'log_level': 'info', 03:18:27 INFO - 'log_name': 'talos', 03:18:27 INFO - 'log_to_console': True, 03:18:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:27 INFO - 'opt_config_files': (), 03:18:27 INFO - 'pip_index': False, 03:18:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:18:27 INFO - 'system_bits': '32', 03:18:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:27 INFO - 'title': 'talos-linux64-ix-006', 03:18:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:27 INFO - 'use_talos_json': True, 03:18:27 INFO - 'verify': 'False', 03:18:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:27 INFO - 'work_dir': 'build'} 03:18:27 INFO - [mozharness: 2017-09-11 10:18:27.810172Z] Running clobber step. 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: clobber 03:18:27 INFO - rmtree: /builds/slave/test/build 03:18:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:28 INFO - Running post-action listener: _resource_record_post_action 03:18:28 INFO - [mozharness: 2017-09-11 10:18:28.891816Z] Finished clobber step (success) 03:18:28 INFO - [mozharness: 2017-09-11 10:18:28.891914Z] Running read-buildbot-config step. 03:18:28 INFO - Running pre-action listener: _resource_record_pre_action 03:18:28 INFO - Running main action method: read_buildbot_config 03:18:28 INFO - Using buildbot properties: 03:18:28 INFO - { 03:18:28 INFO - "project": "", 03:18:28 INFO - "product": "firefox", 03:18:28 INFO - "who": "archaeopteryx@coole-files.de", 03:18:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:18:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:18:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:18:28 INFO - "stage_platform": "linux64", 03:18:28 INFO - "basedir": "/builds/slave/test", 03:18:28 INFO - "buildnumber": 10, 03:18:28 INFO - "platform": "ubuntu64_hw", 03:18:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:28 INFO - "slavebuilddir": "test", 03:18:28 INFO - "taskId": "M8PFnVAhQsuSXUKUflxOXg", 03:18:28 INFO - "branch": "mozilla-central", 03:18:28 INFO - "script_repo_revision": "production", 03:18:28 INFO - "revision": "f9a5e9ed62103c84e4cde915f4d08f1ce71be83e", 03:18:28 INFO - "slavename": "talos-linux64-ix-006", 03:18:28 INFO - "repo_path": "mozilla-central" 03:18:28 INFO - } 03:18:28 INFO - Finding installer, test and symbols from parent task. 03:18:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8PFnVAhQsuSXUKUflxOXg'}, attempt #1 03:18:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8PFnVAhQsuSXUKUflxOXg'}, attempt #1 03:18:29 INFO - Task dependencies: TV-2xJbFQNaqNCVPY33lrg 03:18:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg'}, attempt #1 03:18:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json 03:18:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip 03:18:30 INFO - Running post-action listener: _resource_record_post_action 03:18:30 INFO - [mozharness: 2017-09-11 10:18:30.224339Z] Finished read-buildbot-config step (success) 03:18:30 INFO - [mozharness: 2017-09-11 10:18:30.224557Z] Running download-and-extract step. 03:18:30 INFO - Running pre-action listener: _resource_record_pre_action 03:18:30 INFO - Running main action method: download_and_extract 03:18:30 INFO - mkdir: /builds/slave/test/build/tests 03:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:30 INFO - trying https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json 03:18:30 INFO - Downloading https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:30 INFO - Downloaded 989 bytes. 03:18:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:30 INFO - Using the following test package requirements: 03:18:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:30 INFO - u'common': [u'target.common.tests.zip'], 03:18:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:30 INFO - u'target.web-platform.tests.tar.gz'], 03:18:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:18:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip 03:18:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:30 INFO - Fetch https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip into memory 03:18:31 INFO - Content-Length response header: 55028367 03:18:31 INFO - Bytes received: 55028367 03:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip 03:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip into memory 03:18:43 INFO - Content-Length response header: 14497963 03:18:43 INFO - Bytes received: 14497963 03:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:43 INFO - trying https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:43 INFO - Downloading https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:18:44 INFO - Downloaded 62877338 bytes. 03:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:45 INFO - mkdir: /builds/slave/test/properties 03:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:45 INFO - Contents: 03:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:45 INFO - Running post-action listener: _resource_record_post_action 03:18:45 INFO - Running post-action listener: find_tests_for_verification 03:18:45 INFO - Running post-action listener: set_extra_try_arguments 03:18:45 INFO - [mozharness: 2017-09-11 10:18:45.246913Z] Finished download-and-extract step (success) 03:18:45 INFO - [mozharness: 2017-09-11 10:18:45.247145Z] Running populate-webroot step. 03:18:45 INFO - Running pre-action listener: _resource_record_pre_action 03:18:45 INFO - Running main action method: populate_webroot 03:18:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:45 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['tresize', 03:18:45 INFO - 'tcanvasmark']}, 03:18:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:45 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['dromaeo_css', 03:18:45 INFO - 'kraken']}, 03:18:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:45 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'tests': ['damp', 'tps']}, 03:18:45 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['damp', 'tps']}, 03:18:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:45 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['dromaeo_dom']}, 03:18:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:18:45 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['basic_compositor_video', 03:18:45 INFO - 'glvideo']}, 03:18:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:18:45 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['ts_paint_webext', 03:18:45 INFO - 'tp5o_webext']}, 03:18:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_many_windows', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_many_windows', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:18:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:18:45 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['bloom_basic_singleton']}, 03:18:45 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['bloom_basic']}, 03:18:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:45 INFO - 'tsvgr_opacity', 03:18:45 INFO - 'tart', 03:18:45 INFO - 'tscrollx', 03:18:45 INFO - 'tsvg_static']}, 03:18:45 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['tsvgx', 03:18:45 INFO - 'tsvgr_opacity', 03:18:45 INFO - 'tart', 03:18:45 INFO - 'tscrollx', 03:18:45 INFO - 'tsvg_static']}, 03:18:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:18:45 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo'], 03:18:45 INFO - 'tests': ['tp5o']}, 03:18:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:45 INFO - 'talos_options': ['--mitmproxy', 03:18:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:45 INFO - '--firstNonBlankPaint'], 03:18:45 INFO - 'tests': ['tp6_google', 03:18:45 INFO - 'tp6_youtube', 03:18:45 INFO - 'tp6_amazon', 03:18:45 INFO - 'tp6_facebook']}, 03:18:45 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo', 03:18:45 INFO - '--mitmproxy', 03:18:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:45 INFO - '--firstNonBlankPaint'], 03:18:45 INFO - 'tests': ['tp6_google', 03:18:45 INFO - 'tp6_youtube', 03:18:45 INFO - 'tp6_amazon', 03:18:45 INFO - 'tp6_facebook']}, 03:18:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:45 INFO - 'talos_options': ['--stylo-threads=1', 03:18:45 INFO - '--mitmproxy', 03:18:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:45 INFO - '--firstNonBlankPaint'], 03:18:45 INFO - 'tests': ['tp6_google', 03:18:45 INFO - 'tp6_youtube', 03:18:45 INFO - 'tp6_amazon', 03:18:45 INFO - 'tp6_facebook']}, 03:18:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--xperf_path', 03:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:45 INFO - 'tests': ['tp5n']}, 03:18:45 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-stylo', 03:18:45 INFO - '--xperf_path', 03:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:45 INFO - 'tests': ['tp5n']}}} 03:18:45 INFO - Running post-action listener: _resource_record_post_action 03:18:45 INFO - [mozharness: 2017-09-11 10:18:45.267810Z] Finished populate-webroot step (success) 03:18:45 INFO - [mozharness: 2017-09-11 10:18:45.267900Z] Running create-virtualenv step. 03:18:45 INFO - Running pre-action listener: _resource_record_pre_action 03:18:45 INFO - Running main action method: create_virtualenv 03:18:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:18:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:18:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:18:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:46 INFO - Installing pip...............done. 03:18:46 INFO - Return code: 0 03:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:46 INFO - Reading from file tmpfile_stdout 03:18:46 INFO - Output received: 03:18:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:18:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:46 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:46 INFO - Using env: {'DISPLAY': ':0', 03:18:46 INFO - 'HOME': '/home/cltbld', 03:18:46 INFO - 'LANG': 'en_US.UTF-8', 03:18:46 INFO - 'LANGUAGE': 'en_US:en', 03:18:46 INFO - 'LOGNAME': 'cltbld', 03:18:46 INFO - 'MAIL': '/var/mail/cltbld', 03:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:46 INFO - 'MOZ_NO_REMOTE': '1', 03:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:46 INFO - 'NO_EM_RESTART': '1', 03:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:46 INFO - 'PWD': '/builds/slave/test', 03:18:46 INFO - 'SHELL': '/bin/bash', 03:18:46 INFO - 'SHLVL': '1', 03:18:46 INFO - 'TERM': 'linux', 03:18:46 INFO - 'TMOUT': '86400', 03:18:46 INFO - 'USER': 'cltbld', 03:18:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:46 INFO - '_': '/tools/buildbot/bin/python'} 03:18:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:18:47 INFO - Downloading/unpacking pip>=1.5 03:18:47 INFO - Running setup.py egg_info for package pip 03:18:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:47 INFO - Installing collected packages: pip 03:18:47 INFO - Found existing installation: pip 1.1 03:18:47 INFO - Uninstalling pip: 03:18:47 INFO - Successfully uninstalled pip 03:18:47 INFO - Running setup.py install for pip 03:18:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Successfully installed pip 03:18:47 INFO - Cleaning up... 03:18:47 INFO - Return code: 0 03:18:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:47 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:47 INFO - Using env: {'DISPLAY': ':0', 03:18:47 INFO - 'HOME': '/home/cltbld', 03:18:47 INFO - 'LANG': 'en_US.UTF-8', 03:18:47 INFO - 'LANGUAGE': 'en_US:en', 03:18:47 INFO - 'LOGNAME': 'cltbld', 03:18:47 INFO - 'MAIL': '/var/mail/cltbld', 03:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:47 INFO - 'MOZ_NO_REMOTE': '1', 03:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:47 INFO - 'NO_EM_RESTART': '1', 03:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:47 INFO - 'PWD': '/builds/slave/test', 03:18:47 INFO - 'SHELL': '/bin/bash', 03:18:47 INFO - 'SHLVL': '1', 03:18:47 INFO - 'TERM': 'linux', 03:18:47 INFO - 'TMOUT': '86400', 03:18:47 INFO - 'USER': 'cltbld', 03:18:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:47 INFO - '_': '/tools/buildbot/bin/python'} 03:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:47 INFO - Downloading/unpacking psutil>=3.1.1 03:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:48 INFO - Installing collected packages: psutil 03:18:48 INFO - Running setup.py install for psutil 03:18:48 INFO - building 'psutil._psutil_linux' extension 03:18:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:49 INFO - building 'psutil._psutil_posix' extension 03:18:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:49 INFO - Successfully installed psutil 03:18:49 INFO - Cleaning up... 03:18:49 INFO - Return code: 0 03:18:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:18:49 INFO - Using env: {'DISPLAY': ':0', 03:18:49 INFO - 'HOME': '/home/cltbld', 03:18:49 INFO - 'LANG': 'en_US.UTF-8', 03:18:49 INFO - 'LANGUAGE': 'en_US:en', 03:18:49 INFO - 'LOGNAME': 'cltbld', 03:18:49 INFO - 'MAIL': '/var/mail/cltbld', 03:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:49 INFO - 'MOZ_NO_REMOTE': '1', 03:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:49 INFO - 'NO_EM_RESTART': '1', 03:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:49 INFO - 'PWD': '/builds/slave/test', 03:18:49 INFO - 'SHELL': '/bin/bash', 03:18:49 INFO - 'SHLVL': '1', 03:18:49 INFO - 'TERM': 'linux', 03:18:49 INFO - 'TMOUT': '86400', 03:18:49 INFO - 'USER': 'cltbld', 03:18:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:49 INFO - '_': '/tools/buildbot/bin/python'} 03:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:50 INFO - Installing collected packages: mozsystemmonitor 03:18:50 INFO - Running setup.py install for mozsystemmonitor 03:18:50 INFO - Successfully installed mozsystemmonitor 03:18:50 INFO - Cleaning up... 03:18:51 INFO - Return code: 0 03:18:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:51 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:51 INFO - Using env: {'DISPLAY': ':0', 03:18:51 INFO - 'HOME': '/home/cltbld', 03:18:51 INFO - 'LANG': 'en_US.UTF-8', 03:18:51 INFO - 'LANGUAGE': 'en_US:en', 03:18:51 INFO - 'LOGNAME': 'cltbld', 03:18:51 INFO - 'MAIL': '/var/mail/cltbld', 03:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:51 INFO - 'MOZ_NO_REMOTE': '1', 03:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:51 INFO - 'NO_EM_RESTART': '1', 03:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:51 INFO - 'PWD': '/builds/slave/test', 03:18:51 INFO - 'SHELL': '/bin/bash', 03:18:51 INFO - 'SHLVL': '1', 03:18:51 INFO - 'TERM': 'linux', 03:18:51 INFO - 'TMOUT': '86400', 03:18:51 INFO - 'USER': 'cltbld', 03:18:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:51 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:53 INFO - warning: no files found matching '*.txt' 03:18:53 INFO - no previously-included directories found matching 'build' 03:18:53 INFO - no previously-included directories found matching 'dist' 03:18:53 INFO - no previously-included directories found matching '.git*' 03:18:53 INFO - Installing collected packages: jsonschema, functools32 03:18:53 INFO - Running setup.py install for functools32 03:18:53 INFO - warning: no files found matching '*.txt' 03:18:53 INFO - no previously-included directories found matching 'build' 03:18:53 INFO - no previously-included directories found matching 'dist' 03:18:53 INFO - no previously-included directories found matching '.git*' 03:18:53 INFO - Successfully installed jsonschema functools32 03:18:53 INFO - Cleaning up... 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:18:53 INFO - Using env: {'DISPLAY': ':0', 03:18:53 INFO - 'HOME': '/home/cltbld', 03:18:53 INFO - 'LANG': 'en_US.UTF-8', 03:18:53 INFO - 'LANGUAGE': 'en_US:en', 03:18:53 INFO - 'LOGNAME': 'cltbld', 03:18:53 INFO - 'MAIL': '/var/mail/cltbld', 03:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:53 INFO - 'MOZ_NO_REMOTE': '1', 03:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:53 INFO - 'NO_EM_RESTART': '1', 03:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:53 INFO - 'PWD': '/builds/slave/test', 03:18:53 INFO - 'SHELL': '/bin/bash', 03:18:53 INFO - 'SHLVL': '1', 03:18:53 INFO - 'TERM': 'linux', 03:18:53 INFO - 'TMOUT': '86400', 03:18:53 INFO - 'USER': 'cltbld', 03:18:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:53 INFO - '_': '/tools/buildbot/bin/python'} 03:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:53 INFO - Cleaning up... 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:54 INFO - Using env: {'DISPLAY': ':0', 03:18:54 INFO - 'HOME': '/home/cltbld', 03:18:54 INFO - 'LANG': 'en_US.UTF-8', 03:18:54 INFO - 'LANGUAGE': 'en_US:en', 03:18:54 INFO - 'LOGNAME': 'cltbld', 03:18:54 INFO - 'MAIL': '/var/mail/cltbld', 03:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:54 INFO - 'MOZ_NO_REMOTE': '1', 03:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:54 INFO - 'NO_EM_RESTART': '1', 03:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:54 INFO - 'PWD': '/builds/slave/test', 03:18:54 INFO - 'SHELL': '/bin/bash', 03:18:54 INFO - 'SHLVL': '1', 03:18:54 INFO - 'TERM': 'linux', 03:18:54 INFO - 'TMOUT': '86400', 03:18:54 INFO - 'USER': 'cltbld', 03:18:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:54 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Downloading docopt-0.6.1.tar.gz 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:55 INFO - Running setup.py install for blobuploader 03:18:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:56 INFO - Running setup.py install for requests 03:18:56 INFO - Running setup.py install for docopt 03:18:56 INFO - Successfully installed blobuploader requests docopt 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:56 INFO - Running setup.py (path:/tmp/pip-6CqF7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:56 INFO - Running setup.py (path:/tmp/pip-m_72KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:56 INFO - Running setup.py (path:/tmp/pip-dhh_ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:56 INFO - Running setup.py (path:/tmp/pip-r0VdA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:56 INFO - Running setup.py (path:/tmp/pip-tub8rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:57 INFO - Running setup.py (path:/tmp/pip-375YrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:57 INFO - Running setup.py (path:/tmp/pip-9zrIrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:57 INFO - Running setup.py (path:/tmp/pip-tFNC0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:57 INFO - Running setup.py (path:/tmp/pip-Y7_Zvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:57 INFO - Running setup.py (path:/tmp/pip-bwyGSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:57 INFO - Running setup.py (path:/tmp/pip-L2lD7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:57 INFO - Running setup.py (path:/tmp/pip-EBe1g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:57 INFO - Running setup.py (path:/tmp/pip-8gc7zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:57 INFO - Running setup.py (path:/tmp/pip-pxYl_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:57 INFO - Running setup.py (path:/tmp/pip-uFXkzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:57 INFO - Running setup.py (path:/tmp/pip-787Dkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:57 INFO - Running setup.py (path:/tmp/pip-X84h0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:57 INFO - Running setup.py install for manifestparser 03:18:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:57 INFO - Running setup.py install for mozcrash 03:18:58 INFO - Running setup.py install for mozdebug 03:18:58 INFO - Running setup.py install for mozdevice 03:18:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozfile 03:18:58 INFO - Running setup.py install for mozhttpd 03:18:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozinfo 03:18:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozInstall 03:18:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozleak 03:18:58 INFO - Running setup.py install for mozlog 03:18:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for moznetwork 03:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozprocess 03:18:59 INFO - Running setup.py install for mozprofile 03:18:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozrunner 03:18:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozscreenshot 03:18:59 INFO - Running setup.py install for moztest 03:18:59 INFO - Running setup.py install for mozversion 03:18:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:59 INFO - Running setup.py (path:/tmp/pip-U2xCNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:59 INFO - Running setup.py (path:/tmp/pip-oJxJCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 INFO - Running setup.py (path:/tmp/pip-SFYUHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 INFO - Running setup.py (path:/tmp/pip-j9fSdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:00 INFO - Running setup.py (path:/tmp/pip-hzt9NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 INFO - Running setup.py (path:/tmp/pip-vDeotI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 INFO - Running setup.py (path:/tmp/pip-rGbc6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 INFO - Running setup.py (path:/tmp/pip-Ted45q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:00 INFO - Running setup.py (path:/tmp/pip-q30X86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:00 INFO - Running setup.py (path:/tmp/pip-W2g7sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:00 INFO - Running setup.py (path:/tmp/pip-42uNX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:00 INFO - Running setup.py (path:/tmp/pip-FZ6p5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:00 INFO - Running setup.py (path:/tmp/pip-nIDRTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:00 INFO - Running setup.py (path:/tmp/pip-lODacV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:00 INFO - Running setup.py (path:/tmp/pip-3Rs4Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:00 INFO - Running setup.py (path:/tmp/pip-UKb8Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:01 INFO - Running setup.py (path:/tmp/pip-5ApOLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:19:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:02 INFO - Downloading blessings-1.6.tar.gz 03:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:02 INFO - Installing collected packages: blessings 03:19:02 INFO - Running setup.py install for blessings 03:19:02 INFO - Successfully installed blessings 03:19:02 INFO - Cleaning up... 03:19:02 INFO - Return code: 0 03:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:02 INFO - Reading from file tmpfile_stdout 03:19:02 INFO - Current package versions: 03:19:02 INFO - argparse == 1.2.1 03:19:02 INFO - blessings == 1.6 03:19:02 INFO - blobuploader == 1.2.4 03:19:02 INFO - docopt == 0.6.1 03:19:02 INFO - functools32 == 3.2.3-2 03:19:02 INFO - jsonschema == 2.5.1 03:19:02 INFO - manifestparser == 1.1 03:19:02 INFO - mozInstall == 1.13 03:19:02 INFO - mozcrash == 1.0 03:19:02 INFO - mozdebug == 0.1 03:19:02 INFO - mozdevice == 0.51 03:19:02 INFO - mozfile == 1.2 03:19:02 INFO - mozhttpd == 0.7 03:19:02 INFO - mozinfo == 0.10 03:19:02 INFO - mozleak == 0.1 03:19:02 INFO - mozlog == 3.5 03:19:02 INFO - moznetwork == 0.27 03:19:02 INFO - mozprocess == 0.25 03:19:02 INFO - mozprofile == 0.28 03:19:02 INFO - mozrunner == 6.13 03:19:02 INFO - mozscreenshot == 0.1 03:19:02 INFO - mozsystemmonitor == 0.3 03:19:02 INFO - moztest == 0.8 03:19:02 INFO - mozversion == 1.4 03:19:02 INFO - psutil == 3.1.1 03:19:02 INFO - requests == 1.2.3 03:19:02 INFO - wsgiref == 0.1.2 03:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:02 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:02 INFO - Using env: {'DISPLAY': ':0', 03:19:02 INFO - 'HOME': '/home/cltbld', 03:19:02 INFO - 'LANG': 'en_US.UTF-8', 03:19:02 INFO - 'LANGUAGE': 'en_US:en', 03:19:02 INFO - 'LOGNAME': 'cltbld', 03:19:02 INFO - 'MAIL': '/var/mail/cltbld', 03:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:02 INFO - 'MOZ_NO_REMOTE': '1', 03:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:02 INFO - 'NO_EM_RESTART': '1', 03:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:02 INFO - 'PWD': '/builds/slave/test', 03:19:02 INFO - 'SHELL': '/bin/bash', 03:19:02 INFO - 'SHLVL': '1', 03:19:02 INFO - 'TERM': 'linux', 03:19:02 INFO - 'TMOUT': '86400', 03:19:02 INFO - 'USER': 'cltbld', 03:19:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:02 INFO - '_': '/tools/buildbot/bin/python'} 03:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:19:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:04 INFO - Installing collected packages: simplejson 03:19:04 INFO - Running setup.py install for simplejson 03:19:04 INFO - building 'simplejson._speedups' extension 03:19:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:19:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:19:05 INFO - Successfully installed simplejson 03:19:05 INFO - Cleaning up... 03:19:05 INFO - Return code: 0 03:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:05 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 0x1e571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2020a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:19:05 INFO - Using env: {'DISPLAY': ':0', 03:19:05 INFO - 'HOME': '/home/cltbld', 03:19:05 INFO - 'LANG': 'en_US.UTF-8', 03:19:05 INFO - 'LANGUAGE': 'en_US:en', 03:19:05 INFO - 'LOGNAME': 'cltbld', 03:19:05 INFO - 'MAIL': '/var/mail/cltbld', 03:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:05 INFO - 'MOZ_NO_REMOTE': '1', 03:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:05 INFO - 'NO_EM_RESTART': '1', 03:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:05 INFO - 'PWD': '/builds/slave/test', 03:19:05 INFO - 'SHELL': '/bin/bash', 03:19:05 INFO - 'SHLVL': '1', 03:19:05 INFO - 'TERM': 'linux', 03:19:05 INFO - 'TMOUT': '86400', 03:19:05 INFO - 'USER': 'cltbld', 03:19:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:05 INFO - '_': '/tools/buildbot/bin/python'} 03:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:05 INFO - Cleaning up... 03:19:05 INFO - Return code: 0 03:19:05 INFO - Running post-action listener: _resource_record_post_action 03:19:05 INFO - Running post-action listener: _start_resource_monitoring 03:19:05 INFO - Starting resource monitoring. 03:19:05 INFO - [mozharness: 2017-09-11 10:19:05.371384Z] Finished create-virtualenv step (success) 03:19:05 INFO - [mozharness: 2017-09-11 10:19:05.371932Z] Running install step. 03:19:05 INFO - Running pre-action listener: _resource_record_pre_action 03:19:05 INFO - Running main action method: install 03:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:05 INFO - Reading from file tmpfile_stdout 03:19:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:05 INFO - Reading from file tmpfile_stdout 03:19:05 INFO - Output received: 03:19:05 INFO - Usage: mozinstall [options] installer 03:19:05 INFO - Options: 03:19:05 INFO - -h, --help show this help message and exit 03:19:05 INFO - -d DEST, --destination=DEST 03:19:05 INFO - Directory to install application into. [default: 03:19:05 INFO - "/builds/slave/test"] 03:19:05 INFO - --app=APP Application being installed. [default: firefox] 03:19:05 INFO - mkdir: /builds/slave/test/build/application 03:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:22 INFO - Reading from file tmpfile_stdout 03:19:22 INFO - Output received: 03:19:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:22 INFO - Running post-action listener: _resource_record_post_action 03:19:22 INFO - [mozharness: 2017-09-11 10:19:22.284847Z] Finished install step (success) 03:19:22 INFO - [mozharness: 2017-09-11 10:19:22.285097Z] Running setup-mitmproxy step. 03:19:22 INFO - Running pre-action listener: _resource_record_pre_action 03:19:22 INFO - Running main action method: setup_mitmproxy 03:19:22 INFO - Skipping: mitmproxy is not required 03:19:22 INFO - Running post-action listener: _resource_record_post_action 03:19:22 INFO - [mozharness: 2017-09-11 10:19:22.286237Z] Finished setup-mitmproxy step (success) 03:19:22 INFO - [mozharness: 2017-09-11 10:19:22.286456Z] Running run-tests step. 03:19:22 INFO - Running pre-action listener: _resource_record_pre_action 03:19:22 INFO - Running pre-action listener: _set_gcov_prefix 03:19:22 INFO - Running main action method: run_tests 03:19:22 WARNING - Try message not found. 03:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:22 INFO - Python 2.7.3 03:19:22 INFO - Return code: 0 03:19:22 INFO - grabbing minidump binary from tooltool 03:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:22 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 0x21c7090>, '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 0x21c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:19:22 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:19:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:19:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:22 INFO - Return code: 0 03:19:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:22 INFO - ENV: RUST_BACKTRACE is now full 03:19:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:19:22 INFO - Using env: {'DISPLAY': ':0', 03:19:22 INFO - 'HOME': '/home/cltbld', 03:19:22 INFO - 'LANG': 'en_US.UTF-8', 03:19:22 INFO - 'LANGUAGE': 'en_US:en', 03:19:22 INFO - 'LOGNAME': 'cltbld', 03:19:22 INFO - 'MAIL': '/var/mail/cltbld', 03:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:22 INFO - 'MOZ_NO_REMOTE': '1', 03:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:22 INFO - 'NO_EM_RESTART': '1', 03:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:22 INFO - 'PWD': '/builds/slave/test', 03:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:22 INFO - 'RUST_BACKTRACE': 'full', 03:19:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:22 INFO - 'SHELL': '/bin/bash', 03:19:22 INFO - 'SHLVL': '1', 03:19:22 INFO - 'TERM': 'linux', 03:19:22 INFO - 'TMOUT': '86400', 03:19:22 INFO - 'USER': 'cltbld', 03:19:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:22 INFO - '_': '/tools/buildbot/bin/python'} 03:19:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:19:22 INFO - mozversion application_buildid: 20170911091903 03:19:22 INFO - mozversion application_changeset: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e 03:19:22 INFO - mozversion application_display_name: Nightly 03:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:22 INFO - mozversion application_name: Firefox 03:19:22 INFO - mozversion application_remotingname: firefox 03:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:22 INFO - mozversion application_vendor: Mozilla 03:19:22 INFO - mozversion application_version: 57.0a1 03:19:22 INFO - mozversion platform_buildid: 20170911091903 03:19:22 INFO - mozversion platform_changeset: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e 03:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:22 INFO - mozversion platform_version: 57.0a1 03:19:22 INFO - using testdate: 1505125162 03:19:22 INFO - actual date: 1505125162 03:19:22 INFO - starting webserver on 'localhost:36329' 03:19:22 INFO - SUITE-START | Running 2 tests 03:19:22 INFO - TEST-START | dromaeo_css 03:19:22 INFO - Initialising browser for dromaeo_css test... 03:19:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36329/getInfo.html -profile /tmp/tmpHdec6y/profile 03:19:22 INFO - TEST-INFO | started process 6760 (/builds/slave/test/build/application/firefox/firefox http://localhost:36329/getInfo.html) 03:19:27 INFO - TEST-INFO | 6760: exit 0 03:19:28 INFO - Browser initialized. 03:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:28 INFO - Using env: {'DISPLAY': ':0', 03:19:28 INFO - 'HOME': '/home/cltbld', 03:19:28 INFO - 'JSGC_DISABLE_POISONING': '1', 03:19:28 INFO - 'LANG': 'en_US.UTF-8', 03:19:28 INFO - 'LANGUAGE': 'en_US:en', 03:19:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:19:28 INFO - 'LOGNAME': 'cltbld', 03:19:28 INFO - 'MAIL': '/var/mail/cltbld', 03:19:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:28 INFO - 'MOZ_CRASHREPORTER': '1', 03:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:19:28 INFO - 'MOZ_NO_REMOTE': '1', 03:19:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:28 INFO - 'NO_EM_RESTART': '1', 03:19:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:28 INFO - 'PWD': '/builds/slave/test', 03:19:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:28 INFO - 'RUST_BACKTRACE': 'full', 03:19:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:28 INFO - 'SHELL': '/bin/bash', 03:19:28 INFO - 'SHLVL': '1', 03:19:28 INFO - 'STYLO_FORCE_DISABLED': '1', 03:19:28 INFO - 'TERM': 'linux', 03:19:28 INFO - 'TMOUT': '86400', 03:19:28 INFO - 'USER': 'cltbld', 03:19:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:28 INFO - '_': '/tools/buildbot/bin/python'} 03:19:28 INFO - TEST-INFO | started process 6957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHdec6y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:29 INFO - PID 6957 | 03:19:29 INFO - PID 6957 | (/builds/slave/test/build/application/firefox/firefox:7008): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:29 INFO - PID 6957 | 03:19:39 INFO - PID 6957 | RSS: Main: 170352640 03:19:39 INFO - PID 6957 | 03:22:36 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36329/tests/dromaeo/cssquery-ext.html) 03:22:38 INFO - PID 6957 | RSS: Main: 172777472 03:22:38 INFO - PID 6957 | 03:25:39 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-ext.html (next: http://localhost:36329/tests/dromaeo/cssquery-jquery.html) 03:25:40 INFO - PID 6957 | RSS: Main: 169877504 03:25:40 INFO - PID 6957 | 03:28:42 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36329/tests/dromaeo/cssquery-mootools.html) 03:28:42 INFO - PID 6957 | RSS: Main: 172240896 03:28:42 INFO - PID 6957 | 03:31:44 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36329/tests/dromaeo/cssquery-prototype.html) 03:31:45 INFO - PID 6957 | RSS: Main: 169881600 03:31:45 INFO - PID 6957 | 03:34:48 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36329/tests/dromaeo/cssquery-yui.html) 03:34:49 INFO - PID 6957 | RSS: Main: 171241472 03:34:49 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-yui.html (next: http://localhost:36329/tests/dromaeo/cssquery-dojo.html) 03:37:50 INFO - PID 6957 | RSS: Main: 172265472 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | __start_tp_report 03:37:50 INFO - PID 6957 | _x_x_mozilla_page_load 03:37:50 INFO - PID 6957 | _x_x_mozilla_page_load_details 03:37:50 INFO - PID 6957 | |i|pagename|runs| 03:37:50 INFO - PID 6957 | |0;dojo.html;3154.3375891062874;3176.332970076284;3182.665820088889;3190.728788053016;3192.0902542775316;6180.98013827719;6322.747090116395;6338.809835704925;6459.128017717612;6465.644389558573;6259.092431597415;6302.338254483282;6313.62118272904;6325.6837158142025;6348.49212063035;5778.42215778423;5816.011278082715;5838.766449342022;5895.764169433218;5965.701714914258;5878.1476685880525;5942.554308426886;5944.346121926606;5947.6134051286745;5994.130851026599;1323.4596857871247;5754.510866576346;5766.394528574523;5847.44449277318;5934;5721.141828725683;5752.798652047159;5818.359980402152;5850.912236316459;5851.210086638334;5737.741801618937;5760.36635970043;5809.651420914716;5821.708914554298;5823.272090988627;6256.217972753406;6276;6277.372262773732;6328.493720502349;6358.1734374531015;6705.731770729214;6721.529492935497;6834.043233947202;6859.965700171517;6862.691178896962;6685.264620891698;6775.288594697535;6810.387065164109;6848.863022739517;6942;6342.524310676671;6392.328805475405;6406.551541392105;6407.967960160169;6413.6793160341795;7025.086738723933;7032.437405007587;7117.89323160153;7118.359347658736;7120.928790712027;6519.250286217051;6682.5322227444585;6691.464682825363;6765.05289259504;6778.7288508459105;6696.732130714814;6781.8643627127185;6843.965780171067;6848.760293389708;6855.245922948472;6728.831779205559;6814;6814.046033555306;6817.5909445433435;6818.113645226089;6768.763093291711;6782.253952065269;6799.9800029995895;6862.588244705334;6884.173899132136;5120.590352771769;5239.502247286502;5287.894242115136;5359;5369.382521010056;4584.747838868894;4628.514006029319;4639.605633521189;4650.162970665245;4655.301704744315;5887.293524777054;5904.498117659961;5920.230370051866;5928.940710592925;5935.169076329317;6841.657917104125;6846.938724497711;6858.245592984767;6927.618980956096;6934.410575101072;5723.685197314105;5846.473817356373;5916.852078697981;5929.199558059693;5929.881402371929;5755.65466072037;5761.942380576224;5842.152887831241;5844.824655260349;5856.648601083949;6503.219613646393;6580.670966451658;6586.769463068769;6606.735730570724;6658.700358483783;6738.124043874265;6814.046033555405;6817.216020157745;6902.930970690229;6908.516403851782;6538.869222615616;6579.835504112435;6621.27166011748;6624.966875165594;6637.933620663732;6684.364985326386;6701;6708.295628958889;6708.329167083252;6708.966455167693;6805;6808.93191068083;6830.7609233676585;6832.419244364285;6892.379685828299;6446.8388290293115;6558.573692709959;6563.474922006323;6645.933540664531;6648.800535983928;6554.049662798772;6635.502337324817;6637.004449332639;6656.36764507371;6662.267150613526;6504.349565043458;6509.837254068497;6545.607263564201;6565.474762019123;6594.571352862049;6339.320080178664;6456.7740129095255;6472.805815825533;6677.6661166940485;6758;6342.429181373698;6369.0764839099;6386.90419643715;6387.137736405526;6391.169148010729 03:37:50 INFO - PID 6957 | |1;ext.html;825.9421840471169;826.7643721539358;838.8406202821465;875.5359659380526;875.6366108065149;40515.39226911599;41292.17415651685;41382.37926431102;41400;41409.17181656365;39339.40990885139;40170.799146004305;40172;40265.59734402655;40266.59733402665;7766.339861111812;7871.606419679022;7872.685092596289;7876.173001834783;7882.763517094496;7730.690772369098;7848.979632647776;7850.175731548191;7851.2933835954755;7854.607269636495;7865.646045927919;7889.3688504919755;7890.1715319891155;7890.171531989145;7891.763247102596;7785.649645765954;7830.373570114406;7830.530168189927;7838.451308408442;7845.568493732842;7699.307062364414;7705.653245603961;7719.575423351714;7719.575423351769;7761.805954851117;36911.63088369109;37059.814700926596;37103.81448092769;37157.62842371569;37173.814130929444;3589.6051434342203;3628.564572251347;3632.0738211756097;3634.691051260646;3635.5637323521346;30427.23931901698;30529.69470305313;30557.847210763804;30562.69437305621;30686.693133068606;5213.765380557884;5235.424103348629;5264.815731449381;5269.235960785703;5280.551153151987;175608;176510;177082;177499;177699;44531.33203001958;44649.776751116035;44652.10695786066;44684.55315446869;46513;49581.25628115581;49643.75178124086;49744;49774;49780;15413.614659633598;15505.30226139804;15539.5338139856;15571.221438928234;15758;12749.298788566717;12773.425195866208;12786.488540458278;12847.100702950704;12850.421731022127;14304.427822887175;14343.139411635335;14395.640108997359;14579.708405832036;14700.779488307684;5716.971415142898;5726.482482142235;5781.82654520365;5853.678047707332;5881.088431293157;1005.5726316315537;1010.3331801011298;1020.0615433800921;1021.305512251676;1027.6916924922643;22923.541529169324;22977.310680679606;23039.53920921606;23109.768902311098;23178.42053948631;1112.4993752811267;1112.844201811747;1121.9887801122047;1129.2772625519674;1135.1429670598811;12452.128351015523;12505.93747031259;12547.93726031364;12565.497380104876;12739.490420383267;232908;234301;234534;234577;235554;51064.234036489484;53085.46914530882;56063.43936560664;56171.43828561744;56262.43737562572;1432.3769160415252;1440.3158499712554;1440.7321557029748;1444.50886698523;1451.2163431746737;25946.481070378108;26112.60831087573;26146.215613531625;26433.33916652099;26600.068997584993;36317.27365452729;36705.44941825821;36716.44925326069;36738.26523469569;36804.81597591995;198993;199335;199680;199691;200308;33367.83316083501;33436.498452523716;33668;33808.3238335227;33857.49213761746;40171.39742903917;41530.584694153884;41589.792051040764;41886.37170442385;42098.36852447277;30684.53973190359;30801;30932.22669433282;31625.683743162273;31720.682793171774;29967.850160749058;30227.848860755556;30303;30398.54402184013;30924.69075309218;32327.676723233406;33332.833335833166;33355.16612084717;33601.83199083989;33742.66257337395;29579.112626621234;29684.703152968195;29790.702092978794;30112;30263.09210723682;22098.33704988853;22285.554288914456;22370.664440033088;22442.214522491635;22750 03:37:50 INFO - PID 6957 | |2;jquery.html;562.856471599742;569.1803802524364;575.7927146227357;576.8875069361474;580.3529065092422;21520.677189842147;22094.558108837813;22150.667739983874;22206.1117555298;22232.777672223274;24018.87990560049;24672.38319042025;25081.74918250817;25166.496670066586;25178.370540736443;6302.0861975013595;6390.840228994289;6458.483321334282;6462.25684046336;6467.417932386084;6195.132681424581;6334.144890439778;6428.646424446653;6446.548741588067;6450.903236451457;6420.5505614607;6458.095866578683;6461.386168314003;6474.579152355105;6480.935190648081;6465.8706825863455;6468.644224567647;6472.15861937945;6479.64361960092;6491.058796474508;5899.793507227227;6004.399560044004;6018.488428483584;6123.785667501616;6124.540659450559;27820.582691259446;28157.29606759827;28212.294692632644;28284.151475455565;28310.716892831013;1955.5502234486148;2001.1995201919203;2011.2055737983414;2021.5249416387137;2022.9595408091757;18603.81396186048;18625.161867715986;19091;19274.518137046547;19751.901240493706;2429.720582133042;2450.7426720194303;2490.7384724604017;2492.239866840613;2499.0253801017616;118480;124687;131291;137246.31376843152;137513;14245.358958846877;14531.564053078424;14568.719955059927;14607.44541224196;14731.852681473263;22672.886635566716;22711.659325110137;22765.430864228194;22789.88605056964;22895.542089158458;9428.387154834914;9659;9719.201947639567;9747.512624368754;9891.159251463707;8716.694915677921;8832.38173327861;8919.464832110094;8930.776730581787;8976.41653292534;9051.094890511027;9120.635174592942;9188;9289.72130836076;9290.767730806783;2672;2680.584509401046;2681.2894582935537;2698.757111859942;2735.2614794005904;923.6951805904035;929.0662883801735;935.3125452792192;962.7929995051097;971.9659811906549;18290.99399533012;18475;18748.81251187498;19211.90394048021;19352.903235483733;993.8906720260766;998.7852611688522;1002.0730823987782;1002.3985608634761;1003.9548220330103;10646;10675.679729608124;10696.737495063924;10747.731306717395;10850.348979061282;418187;427621;428085;437060;437101;107026;109169;110115;110878.44560777144;112201.43899280451;1007.4005966449951;1051.8579991701022;1124.2242852431796;1147.3804145761196;1177.1642134084896;20038;20058.799412005694;20187.899060504602;20190.394288171377;20232.79767202368;56714.432855670915;56882.431175687714;57705.422945770006;58730.412695872496;59322.70338648279;71655.64172179314;71681.6415917917;72133;72315.63842180755;72415.63792181005;14148;14377.712445750818;14399.64000899944;14417.78373324422;14438.85561144417;22504.774952250267;22655.433614159778;22707;22823.087076516753;22887.88556057209;18111.909440452713;18240.72638910444;18276.08619569043;18277.817221828143;18285.17716702778;15777.368905243662;16385.262663179947;16471.67056658836;16630.334786608884;16940.237689303765;17261.56846078858;18135.45593632193;18559.81440185581;18612.720809188144;18662.72005919885;14056.156630601787;14254.144751314954;14267.286635667968;14273.928630356782;14275.42898284057;18142.72785908186;18253.269869205615;18262.90868545702;18471.445856624323;18489.90755046216 03:37:50 INFO - PID 6957 | |3;mootools.html;1334.1261473734703;1395.1141025448837;1410.4428750643497;1416.638757116935;1419.4535103984963;14821.184834834079;15669.764953525706;15673.45142919998;15681.451149209779;15693.293801778904;15214.467493637725;15248.313825877834;15288.159151246677;15335.079895206267;15349.309281082351;2660.268426182801;2790.902318418856;2791.6510436195476;2794.6925838157786;2798.1465652975835;2229.2643427668913;2737.835729856205;2758.7930905182093;2795.5247607906704;2796.790240731943;2312.838101332907;2323.5585238804574;2655.787536997045;2772.7365900239547;2782.0819129687256;2610.112561729002;2650.748178922999;2659.933501662464;2666.9599956000675;2681.1018308866555;2639.5248855206055;2650.324167337336;2652.3501742073317;2654.376221587925;2667.2398366465463;14894.478693245685;15021.399144034225;15034.774478382833;15035.323410446446;15041.022333548284;7898.723544675909;8181.468204566684;8183.549904755236;8183.877241841377;8187.345012399053;5114.33513643224;5182.585393168538;5273.789048438058;5317.73411329432;5547.11246200606;1931.2564662604857;1941.3205378117545;1954.9511262218416;1960.9313674021341;1961.3919684897728;26425.207243782716;26443.338916527242;26445.47109057808;26449;26493;7160;7352.889706654404;7361.153467351216;7491.213422590658;7513.361364283987;16581.83418165827;17334.133293335282;17350;19818.20727170926;19867.701984470244;7769.6115194240065;7931.5637639930355;7937.404694647925;7976.282134607914;7979.9601001994615;7171.605561694053;7290.781276561712;7309.232530584319;7342.412606991428;7384.815379615553;4844.273358996179;4991.201407774739;4993.300937868701;5021.6735912165595;5059.165237735732;1355.1327150623608;1382.759928915164;1383.833939927195;1395.2884029145007;1396.8253968253969;872.5724395046382;898.7213963671282;906.5014242166782;907.1403622573697;908.8727578139066;7567.3189412952;7588.468807183444;7611.238876112455;7657.846843063107;7719.459637825298;695.8538706871512;701.6106061136016;713.2617740638518;713.3900515059653;713.5682911838367;4431;4445.088756804847;4464.0402313502755;4468.7710879508395;4470.642348612103;20590;21011.8949405252;21917.890410547847;22067.558648827253;22103.778962210494;21591.2443064492;21620.243291484723;21647.13411463524;21725.565488690452;21766;10777.191710621735;10873.347599144077;10879.945600272107;10913.83629245562;10971.83542246867;7924.722634707758;8032.236937490929;8042.758717238492;8100.554469504234;8163.918360816316;18623.255069797055;18637.813621863606;18854.24583016664;18990.715139273198;19447.61104777925;19352.612947740683;19392.12735426881;19432;19435.90282048637;19568.804311956697;10724.195685323475;10810.945945270223;10910.672679819618;10996.945015274872;11010.284331518425;13591.728165436438;13918.443262269397;13944.16335019902;13955.372008259856;13956.930215348859;11101.389423581457;11127.276727012719;11223.66329010131;11236.269642473213;11455.59905403307;10949.343039417661;11135.777284454103;11171.776564468502;11324.773504530029;11330.150238732293;8603.483790972561;8637.179467950535;8689;8706.695265665672;8707.738767836974;6445.806625801233;6558.376954189344;6583.407493325623;6584.572002819993;6629.933700663125;6685.39831415175;6786.796396108125;6787.762428314985;6826.214985276558;6830.487713421613 03:37:50 INFO - PID 6957 | |4;prototype.html;501.4358846297917;503.95932399594835;525.1204232909876;533.9466053394664;536.3751229817263;6310.621362718229;6333.46165575926;6345.826022185899;6383.202099737533;6406.711697973591;6190.473809726167;6239.688015599225;6267.279262884769;6299.968500157504;6333.8099857004245;5223.608229382802;5226.163813789794;5259.815906443256;5278.181881808326;5283.735813209324;4914.3611330527165;5042.268871013701;5157.5358217760395;5224.29472021278;5259.737013149346;5002.59979201663;5006.924896126561;5025.874353141164;5063.46833582474;5064.265681476184;4978.751062446881;4979.278004689318;4985.925211121836;4995.825146119869;5007;4392.275274579691;4467.888302792424;4482.350059241425;4484.372187893698;4493.11289258509;6090.23872015998;6106.45041946227;6114.545281915748;6129.877402451926;6159.260888693386;5706.343770466408;5717.285339332583;5725.599208055438;5728.68492232927;5731;6581.815273250813;6587.80236592903;6598.868022639568;6612.272650008544;6628.3371662833815;4641.257398816173;4903.338049363361;4909.754512274372;4922.803087876517;4929.309896614477;6756.763513277061;6793.728250869959;6814.897776533307;6922.8615427692175;6945.51381403307;5021.723805190676;5024.71869673231;5025.321581586512;5036.320096786887;5043.52086551777;5075.365579302587;5092.26162206478;5095.929550097677;5113.616478764107;5114.232865070269;5726.541876649858;5738.139279108167;5744.655320680772;5756.798512052058;5780.855478612984;6679.465642748569;6681.866362672817;6691.698873550702;6705.357187489097;6742.347780031762;1722.2852516205885;1747.554373634715;1765.0292339213381;1765.540959350578;1770.8140645232322;1174.8648905375992;1221.5297110612478;1222.9877701222874;1223.2232532342027;1236.567201479475;5701.572382071278;5723.198752174699;5780.335261444988;5782.942170578324;5783.103618939072;6700.229473610597;6711.429528490035;6716.026176204521;6760.594364338155;6837;5653.823278037985;5656.123300888369;5701;5712.543301458101;5732.111522713986;3554.7689400188906;3574.946375804365;3576.3562558739154;3586.246888153517;3641.417373220325;6430.646314452656;6465.935340646627;6497.18785151856;6509.707063182168;6521.445677117404;6538.476921846241;6755.256921738604;6760.323967603299;6838.196339500781;6852.965735171392;6406.455451286693;6428.200103970708;6431.581947173512;6455.677216139268;6510.5117116217425;6740.595564266159;6740.730370785113;6746.426553742791;6749.603890618956;6771;6603.085105319404;6634.767783127568;6680.665966701548;6696.933030669631;6699.908069867034;6457.773977910939;6463.967680161757;6490.383413575702;6494.7077381517;6522.934770652422;4942.047891083074;4945.530174633404;5032.169692000925;5043.394792624762;5044.470330615232;6500.219973603198;6571.539992200691;6687.7596005338755;6756.628385438848;6828.507594727789;6362.554621176473;6548.443382312556;6560.606363618198;6582.934170658232;6614.669266536558;6509.511786615928;6595.340465953366;6601.669916504252;6603.250138713341;6619.50353723463;6463.838404039937;6466.61200327963;6467.902981455376;6471.835069687313;6489;6527.445167160845;6531.3468653134305;6567.27759946396;6579.342065793574;6607.900881486686;6290.842728931813;6291.559590828598;6298.149749783721;6421.229452465547;6429.421352078335 03:37:50 INFO - PID 6957 | |5;yui.html;886.1006078829987;893.7631527645175;914.8627705844123;915.3866909170855;927.4852456886427;17179.226934787934;17584.38454654084;17612.29550817967;17624.911875440604;17660.205290761915;16931.06879121648;17043.403480878173;17055.658886822257;17085.31658733652;17150.485485435427;942.208544822349;965.6137544982029;967.0184762466102;967.4340510801189;969.0890562870914;966.463612694954;981.6711401680445;982.0277924854414;983.5868935047297;984.1044649369076;993.8658281132027;997.5909876950452;1018.3024628129717;1030.562011145264;1034.5861655337849;1010.9494525273743;1027.2706378471294;1028.2236911132047;1028.228828378716;1028.9228307876901;731.1664702239451;743.5501521579421;744.0178963767829;751.3012898004853;757.2124990010383;20149.09329080195;20373.898130509253;20430.795692043037;20458.283960061326;20465.693014604793;21046.47383815417;21177.258795942224;22028.33914982553;22145.889270553544;22160.778392216034;16866.91566542172;17032.063236521986;17106.828931710646;17162.31350745981;17313.7402938956;3698.204885949534;3731.589525152231;3731.9067023324365;3732.794696291703;3733.197362567034;100331;133238.33380833032;134470;135938;136665.316673416;16850.831491684927;16970.830291697173;17177.65644687099;17192.656146876994;17197.1401429928;29156;29320.26699332534;29920.102396928127;29963.550546741815;30134.849325753232;9236.8614470783;9359.859602105973;9371.484568348806;9374.203192728695;9392.436453812794;4347.391365208873;4377.4965878923695;4508.301213311942;4518.864434066983;4520.434945631796;5334.226537152092;5346.144616861284;5438.401775804658;5442.782288708487;5454.91817622736;1034.5861655337926;1060.8567843341204;1068.4550879051585;1069.2301542889106;1072.3887384190937;686.6017709728345;699.7830672491544;701.9403350715246;707.536563550875;718.2279050021248;10815.86433424479;11563.42182890869;11651.184417090892;12330.383480825923;12362.814557781641;677.4241894389828;687.412262515552;697.052009267396;699.2622782964022;702.1784512120831;5833.562482813806;5851.970740146272;5951.5238780897425;5951.791687290924;5998.850028749316;115600.42199789116;115615.42192288984;117711.41144294223;118105.40947295209;119873;100220.49889750505;101305;101690.4915475418;106390;107067;91363;93273;94510;96796.51601741946;97034.51482742683;10997;11015.889841101487;11094.500747466222;11127.221094523306;11235.101191904465;42836.14327713366;45059.54940450554;45149;45713.08573828438;46160.53839461562;56524.71737641285;56825.431745683665;57178.7141064292;57270;58762.70618646879;15622.531324060297;15867;15996.680066398374;16079.196040198178;16110.67778644444;17735.82264177393;17870.106494675474;17922.5519362017;18029.188686508875;18047.819521804613;15984;16126;16145;16424.589385265463;16444.342226310815;16268.674626507167;16457.094859782348;16490.75263871019;16624.50126496207;16634.3346266148;14354.928225358806;14484.130952142905;14491.637709056937;14554.12675239489;14698.63253418673;11592.710182245512;11634.70913227176;11766.647000589996;11806.527738890349;11857.822132668189;12732.936335318263;12777.680557986125;12799.720027997126;12830.615081547568;13020.41408136655 03:37:50 INFO - PID 6957 | __end_tp_report 03:37:50 INFO - PID 6957 | __start_cc_report 03:37:50 INFO - PID 6957 | _x_x_mozilla_cycle_collect,385 03:37:50 INFO - PID 6957 | __end_cc_report 03:37:50 INFO - PID 6957 | __startTimestamp1505126270972__endTimestamp 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | ------- Summary: start ------- 03:37:50 INFO - PID 6957 | Number of tests: 6 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#0] dojo.html Cycles:165 Average:6219.99 Median:6465.64 stddev:848.72 (13.1%) stddev-sans-first:816.53 03:37:50 INFO - PID 6957 | Values: 3154.3 3176.3 3182.7 3190.7 3192.1 6181.0 6322.7 6338.8 6459.1 6465.6 6259.1 6302.3 6313.6 6325.7 6348.5 5778.4 5816.0 5838.8 5895.8 5965.7 5878.1 5942.6 5944.3 5947.6 5994.1 1323.5 5754.5 5766.4 5847.4 5934.0 5721.1 5752.8 5818.4 5850.9 5851.2 5737.7 5760.4 5809.7 5821.7 5823.3 6256.2 6276.0 6277.4 6328.5 6358.2 6705.7 6721.5 6834.0 6860.0 6862.7 6685.3 6775.3 6810.4 6848.9 6942.0 6342.5 6392.3 6406.6 6408.0 6413.7 7025.1 7032.4 7117.9 7118.4 7120.9 6519.3 6682.5 6691.5 6765.1 6778.7 6696.7 6781.9 6844.0 6848.8 6855.2 6728.8 6814.0 6814.0 6817.6 6818.1 6768.8 6782.3 6800.0 6862.6 6884.2 5120.6 5239.5 5287.9 5359.0 5369.4 4584.7 4628.5 4639.6 4650.2 4655.3 5887.3 5904.5 5920.2 5928.9 5935.2 6841.7 6846.9 6858.2 6927.6 6934.4 5723.7 5846.5 5916.9 5929.2 5929.9 5755.7 5761.9 5842.2 5844.8 5856.6 6503.2 6580.7 6586.8 6606.7 6658.7 6738.1 6814.0 6817.2 6902.9 6908.5 6538.9 6579.8 6621.3 6625.0 6637.9 6684.4 6701.0 6708.3 6708.3 6709.0 6805.0 6808.9 6830.8 6832.4 6892.4 6446.8 6558.6 6563.5 6645.9 6648.8 6554.0 6635.5 6637.0 6656.4 6662.3 6504.3 6509.8 6545.6 6565.5 6594.6 6339.3 6456.8 6472.8 6677.7 6758.0 6342.4 6369.1 6386.9 6387.1 6391.2 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#1] ext.html Cycles:180 Average:36963.01 Median:33634.92 stddev:53095.65 (157.9%) stddev-sans-first:53175.26 03:37:50 INFO - PID 6957 | Values: 825.9 826.8 838.8 875.5 875.6 40515.4 41292.2 41382.4 41400.0 41409.2 39339.4 40170.8 40172.0 40265.6 40266.6 7766.3 7871.6 7872.7 7876.2 7882.8 7730.7 7849.0 7850.2 7851.3 7854.6 7865.6 7889.4 7890.2 7890.2 7891.8 7785.6 7830.4 7830.5 7838.5 7845.6 7699.3 7705.7 7719.6 7719.6 7761.8 36911.6 37059.8 37103.8 37157.6 37173.8 3589.6 3628.6 3632.1 3634.7 3635.6 30427.2 30529.7 30557.8 30562.7 30686.7 5213.8 5235.4 5264.8 5269.2 5280.6 175608.0 176510.0 177082.0 177499.0 177699.0 44531.3 44649.8 44652.1 44684.6 46513.0 49581.3 49643.8 49744.0 49774.0 49780.0 15413.6 15505.3 15539.5 15571.2 15758.0 12749.3 12773.4 12786.5 12847.1 12850.4 14304.4 14343.1 14395.6 14579.7 14700.8 5717.0 5726.5 5781.8 5853.7 5881.1 1005.6 1010.3 1020.1 1021.3 1027.7 22923.5 22977.3 23039.5 23109.8 23178.4 1112.5 1112.8 1122.0 1129.3 1135.1 12452.1 12505.9 12547.9 12565.5 12739.5 232908.0 234301.0 234534.0 234577.0 235554.0 51064.2 53085.5 56063.4 56171.4 56262.4 1432.4 1440.3 1440.7 1444.5 1451.2 25946.5 26112.6 26146.2 26433.3 26600.1 36317.3 36705.4 36716.4 36738.3 36804.8 198993.0 199335.0 199680.0 199691.0 200308.0 33367.8 33436.5 33668.0 33808.3 33857.5 40171.4 41530.6 41589.8 41886.4 42098.4 30684.5 30801.0 30932.2 31625.7 31720.7 29967.9 30227.8 30303.0 30398.5 30924.7 32327.7 33332.8 33355.2 33601.8 33742.7 29579.1 29684.7 29790.7 30112.0 30263.1 22098.3 22285.6 22370.7 22442.2 22750.0 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#2] jquery.html Cycles:180 Average:32587.86 Median:22855.49 stddev:72937.94 (319.1%) stddev-sans-first:73102.92 03:37:50 INFO - PID 6957 | Values: 562.9 569.2 575.8 576.9 580.4 21520.7 22094.6 22150.7 22206.1 22232.8 24018.9 24672.4 25081.7 25166.5 25178.4 6302.1 6390.8 6458.5 6462.3 6467.4 6195.1 6334.1 6428.6 6446.5 6450.9 6420.6 6458.1 6461.4 6474.6 6480.9 6465.9 6468.6 6472.2 6479.6 6491.1 5899.8 6004.4 6018.5 6123.8 6124.5 27820.6 28157.3 28212.3 28284.2 28310.7 1955.6 2001.2 2011.2 2021.5 2023.0 18603.8 18625.2 19091.0 19274.5 19751.9 2429.7 2450.7 2490.7 2492.2 2499.0 118480.0 124687.0 131291.0 137246.3 137513.0 14245.4 14531.6 14568.7 14607.4 14731.9 22672.9 22711.7 22765.4 22789.9 22895.5 9428.4 9659.0 9719.2 9747.5 9891.2 8716.7 8832.4 8919.5 8930.8 8976.4 9051.1 9120.6 9188.0 9289.7 9290.8 2672.0 2680.6 2681.3 2698.8 2735.3 923.7 929.1 935.3 962.8 972.0 18291.0 18475.0 18748.8 19211.9 19352.9 993.9 998.8 1002.1 1002.4 1004.0 10646.0 10675.7 10696.7 10747.7 10850.3 418187.0 427621.0 428085.0 437060.0 437101.0 107026.0 109169.0 110115.0 110878.4 112201.4 1007.4 1051.9 1124.2 1147.4 1177.2 20038.0 20058.8 20187.9 20190.4 20232.8 56714.4 56882.4 57705.4 58730.4 59322.7 71655.6 71681.6 72133.0 72315.6 72415.6 14148.0 14377.7 14399.6 14417.8 14438.9 22504.8 22655.4 22707.0 22823.1 22887.9 18111.9 18240.7 18276.1 18277.8 18285.2 15777.4 16385.3 16471.7 16630.3 16940.2 17261.6 18135.5 18559.8 18612.7 18662.7 14056.2 14254.1 14267.3 14273.9 14275.4 18142.7 18253.3 18262.9 18471.4 18489.9 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#3] mootools.html Cycles:180 Average:9245.47 Median:2650.54 stddev:6780.02 (255.8%) stddev-sans-first:6772.98 03:37:50 INFO - PID 6957 | Values: 1334.1 1395.1 1410.4 1416.6 1419.5 14821.2 15669.8 15673.5 15681.5 15693.3 15214.5 15248.3 15288.2 15335.1 15349.3 2660.3 2790.9 2791.7 2794.7 2798.1 2229.3 2737.8 2758.8 2795.5 2796.8 2312.8 2323.6 2655.8 2772.7 2782.1 2610.1 2650.7 2659.9 2667.0 2681.1 2639.5 2650.3 2652.4 2654.4 2667.2 14894.5 15021.4 15034.8 15035.3 15041.0 7898.7 8181.5 8183.5 8183.9 8187.3 5114.3 5182.6 5273.8 5317.7 5547.1 1931.3 1941.3 1955.0 1960.9 1961.4 26425.2 26443.3 26445.5 26449.0 26493.0 7160.0 7352.9 7361.2 7491.2 7513.4 16581.8 17334.1 17350.0 19818.2 19867.7 7769.6 7931.6 7937.4 7976.3 7980.0 7171.6 7290.8 7309.2 7342.4 7384.8 4844.3 4991.2 4993.3 5021.7 5059.2 1355.1 1382.8 1383.8 1395.3 1396.8 872.6 898.7 906.5 907.1 908.9 7567.3 7588.5 7611.2 7657.8 7719.5 695.9 701.6 713.3 713.4 713.6 4431.0 4445.1 4464.0 4468.8 4470.6 20590.0 21011.9 21917.9 22067.6 22103.8 21591.2 21620.2 21647.1 21725.6 21766.0 10777.2 10873.3 10879.9 10913.8 10971.8 7924.7 8032.2 8042.8 8100.6 8163.9 18623.3 18637.8 18854.2 18990.7 19447.6 19352.6 19392.1 19432.0 19435.9 19568.8 10724.2 10810.9 10910.7 10996.9 11010.3 13591.7 13918.4 13944.2 13955.4 13956.9 11101.4 11127.3 11223.7 11236.3 11455.6 10949.3 11135.8 11171.8 11324.8 11330.2 8603.5 8637.2 8689.0 8706.7 8707.7 6445.8 6558.4 6583.4 6584.6 6629.9 6685.4 6786.8 6787.8 6826.2 6830.5 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#4] prototype.html Cycles:180 Average:5534.15 Median:6215.08 stddev:1544.02 (24.8%) stddev-sans-first:1501.43 03:37:50 INFO - PID 6957 | Values: 501.4 504.0 525.1 533.9 536.4 6310.6 6333.5 6345.8 6383.2 6406.7 6190.5 6239.7 6267.3 6300.0 6333.8 5223.6 5226.2 5259.8 5278.2 5283.7 4914.4 5042.3 5157.5 5224.3 5259.7 5002.6 5006.9 5025.9 5063.5 5064.3 4978.8 4979.3 4985.9 4995.8 5007.0 4392.3 4467.9 4482.4 4484.4 4493.1 6090.2 6106.5 6114.5 6129.9 6159.3 5706.3 5717.3 5725.6 5728.7 5731.0 6581.8 6587.8 6598.9 6612.3 6628.3 4641.3 4903.3 4909.8 4922.8 4929.3 6756.8 6793.7 6814.9 6922.9 6945.5 5021.7 5024.7 5025.3 5036.3 5043.5 5075.4 5092.3 5095.9 5113.6 5114.2 5726.5 5738.1 5744.7 5756.8 5780.9 6679.5 6681.9 6691.7 6705.4 6742.3 1722.3 1747.6 1765.0 1765.5 1770.8 1174.9 1221.5 1223.0 1223.2 1236.6 5701.6 5723.2 5780.3 5782.9 5783.1 6700.2 6711.4 6716.0 6760.6 6837.0 5653.8 5656.1 5701.0 5712.5 5732.1 3554.8 3574.9 3576.4 3586.2 3641.4 6430.6 6465.9 6497.2 6509.7 6521.4 6538.5 6755.3 6760.3 6838.2 6853.0 6406.5 6428.2 6431.6 6455.7 6510.5 6740.6 6740.7 6746.4 6749.6 6771.0 6603.1 6634.8 6680.7 6696.9 6699.9 6457.8 6464.0 6490.4 6494.7 6522.9 4942.0 4945.5 5032.2 5043.4 5044.5 6500.2 6571.5 6687.8 6756.6 6828.5 6362.6 6548.4 6560.6 6582.9 6614.7 6509.5 6595.3 6601.7 6603.3 6619.5 6463.8 6466.6 6467.9 6471.8 6489.0 6527.4 6531.3 6567.3 6579.3 6607.9 6290.8 6291.6 6298.1 6421.2 6429.4 03:37:50 INFO - PID 6957 | 03:37:50 INFO - PID 6957 | [#5] yui.html Cycles:180 Average:23658.78 Median:17975.87 stddev:33518.04 (186.5%) stddev-sans-first:33568.45 03:37:50 INFO - PID 6957 | Values: 886.1 893.8 914.9 915.4 927.5 17179.2 17584.4 17612.3 17624.9 17660.2 16931.1 17043.4 17055.7 17085.3 17150.5 942.2 965.6 967.0 967.4 969.1 966.5 981.7 982.0 983.6 984.1 993.9 997.6 1018.3 1030.6 1034.6 1010.9 1027.3 1028.2 1028.2 1028.9 731.2 743.6 744.0 751.3 757.2 20149.1 20373.9 20430.8 20458.3 20465.7 21046.5 21177.3 22028.3 22145.9 22160.8 16866.9 17032.1 17106.8 17162.3 17313.7 3698.2 3731.6 3731.9 3732.8 3733.2 100331.0 133238.3 134470.0 135938.0 136665.3 16850.8 16970.8 17177.7 17192.7 17197.1 29156.0 29320.3 29920.1 29963.6 30134.8 9236.9 9359.9 9371.5 9374.2 9392.4 4347.4 4377.5 4508.3 4518.9 4520.4 5334.2 5346.1 5438.4 5442.8 5454.9 1034.6 1060.9 1068.5 1069.2 1072.4 686.6 699.8 701.9 707.5 718.2 10815.9 11563.4 11651.2 12330.4 12362.8 677.4 687.4 697.1 699.3 702.2 5833.6 5852.0 5951.5 5951.8 5998.9 115600.4 115615.4 117711.4 118105.4 119873.0 100220.5 101305.0 101690.5 106390.0 107067.0 91363.0 93273.0 94510.0 96796.5 97034.5 10997.0 11015.9 11094.5 11127.2 11235.1 42836.1 45059.5 45149.0 45713.1 46160.5 56524.7 56825.4 57178.7 57270.0 58762.7 15622.5 15867.0 15996.7 16079.2 16110.7 17735.8 17870.1 17922.6 18029.2 18047.8 15984.0 16126.0 16145.0 16424.6 16444.3 16268.7 16457.1 16490.8 16624.5 16634.3 14354.9 14484.1 14491.6 14554.1 14698.6 11592.7 11634.7 11766.6 11806.5 11857.8 12732.9 12777.7 12799.7 12830.6 13020.4 03:37:50 INFO - PID 6957 | -------- Summary: end -------- 03:37:50 INFO - PID 6957 | 03:37:51 INFO - TEST-INFO | 6957: exit 0 03:37:51 INFO - TEST-OK | dromaeo_css | took 1109059ms 03:37:51 INFO - TEST-START | kraken 03:37:51 INFO - Initialising browser for kraken test... 03:37:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36329/getInfo.html -profile /tmp/tmpvL_HQz/profile 03:37:51 INFO - TEST-INFO | started process 7329 (/builds/slave/test/build/application/firefox/firefox http://localhost:36329/getInfo.html) 03:37:56 INFO - TEST-INFO | 7329: exit 0 03:37:56 INFO - Browser initialized. 03:37:56 INFO - Running cycle 1/1 for kraken test... 03:37:56 INFO - Using env: {'DISPLAY': ':0', 03:37:56 INFO - 'HOME': '/home/cltbld', 03:37:56 INFO - 'JSGC_DISABLE_POISONING': '1', 03:37:56 INFO - 'LANG': 'en_US.UTF-8', 03:37:56 INFO - 'LANGUAGE': 'en_US:en', 03:37:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:37:56 INFO - 'LOGNAME': 'cltbld', 03:37:56 INFO - 'MAIL': '/var/mail/cltbld', 03:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:56 INFO - 'MOZ_CRASHREPORTER': '1', 03:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:37:56 INFO - 'MOZ_NO_REMOTE': '1', 03:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:56 INFO - 'NO_EM_RESTART': '1', 03:37:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:56 INFO - 'PWD': '/builds/slave/test', 03:37:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:56 INFO - 'RUST_BACKTRACE': 'full', 03:37:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:37:56 INFO - 'SHELL': '/bin/bash', 03:37:56 INFO - 'SHLVL': '1', 03:37:56 INFO - 'STYLO_FORCE_DISABLED': '1', 03:37:56 INFO - 'TERM': 'linux', 03:37:56 INFO - 'TMOUT': '86400', 03:37:56 INFO - 'USER': 'cltbld', 03:37:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321', 03:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:56 INFO - '_': '/tools/buildbot/bin/python'} 03:37:56 INFO - TEST-INFO | started process 7522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvL_HQz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:57 INFO - PID 7522 | 03:37:57 INFO - PID 7522 | (/builds/slave/test/build/application/firefox/firefox:7573): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:37:57 INFO - PID 7522 | 03:38:08 INFO - PID 7522 | RSS: Main: 170446848 03:38:08 INFO - PID 7522 | 03:38:10 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:11 INFO - PID 7522 | RSS: Main: 176975872 03:38:11 INFO - PID 7522 | 03:38:14 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-dft) 03:38:15 INFO - PID 7522 | RSS: Main: 177487872 03:38:15 INFO - PID 7522 | 03:38:18 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-fft) 03:38:18 INFO - PID 7522 | RSS: Main: 171724800 03:38:18 INFO - PID 7522 | 03:38:20 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-oscillator) 03:38:21 INFO - PID 7522 | RSS: Main: 172584960 03:38:21 INFO - PID 7522 | 03:38:23 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:24 INFO - PID 7522 | RSS: Main: 172822528 03:38:24 INFO - PID 7522 | 03:38:27 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:27 INFO - PID 7522 | RSS: Main: 175017984 03:38:27 INFO - PID 7522 | 03:38:31 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:32 INFO - PID 7522 | RSS: Main: 174669824 03:38:32 INFO - PID 7522 | 03:38:35 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36329/tests/kraken/driver.html?testName=json-parse-financial) 03:38:35 INFO - PID 7522 | RSS: Main: 174440448 03:38:35 INFO - PID 7522 | 03:38:37 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:38 INFO - PID 7522 | RSS: Main: 174784512 03:38:38 INFO - PID 7522 | 03:38:39 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:40 INFO - PID 7522 | RSS: Main: 174563328 03:38:40 INFO - PID 7522 | 03:38:42 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:43 INFO - PID 7522 | RSS: Main: 171765760 03:38:43 INFO - PID 7522 | 03:38:45 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:46 INFO - PID 7522 | RSS: Main: 172199936 03:38:46 INFO - PID 7522 | 03:38:49 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:50 INFO - PID 7522 | RSS: Main: 172507136 03:38:50 INFO - PID 7522 | 03:38:51 INFO - PID 7522 | Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36329/tests/kraken/driver.html?testName=ai-astar) 03:38:52 INFO - PID 7522 | RSS: Main: 173842432 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | __start_tp_report 03:38:52 INFO - PID 7522 | _x_x_mozilla_page_load 03:38:52 INFO - PID 7522 | _x_x_mozilla_page_load_details 03:38:52 INFO - PID 7522 | |i|pagename|runs| 03:38:52 INFO - PID 7522 | |0;ai-astar;108;108;109;107;109;108;109;108;108;107 03:38:52 INFO - PID 7522 | |1;audio-beat-detection;117;117;117;115;116;116;122;121;117;116 03:38:52 INFO - PID 7522 | |2;audio-dft;164;161;164;163;164;162;167;166;170;164 03:38:52 INFO - PID 7522 | |3;audio-fft;75;73;72;73;74;74;72;74;74;77 03:38:52 INFO - PID 7522 | |4;audio-oscillator;79;78;80;80;79;79;80;79;78;85 03:38:52 INFO - PID 7522 | |5;imaging-gaussian-blur;112;113;113;113;114;114;113;114;117;114 03:38:52 INFO - PID 7522 | |6;imaging-darkroom;148;150;147;148;148;149;148;148;148;148 03:38:52 INFO - PID 7522 | |7;imaging-desaturate;96;94;93;94;94;94;94;93;94;94 03:38:52 INFO - PID 7522 | |8;json-parse-financial;56;54;53;54;56;53;54;54;55;52 03:38:52 INFO - PID 7522 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;39 03:38:52 INFO - PID 7522 | |10;stanford-crypto-aes;77;75;76;76;75;79;74;79;76;75 03:38:52 INFO - PID 7522 | |11;stanford-crypto-ccm;142;123;123;126;123;122;130;124;124;115 03:38:52 INFO - PID 7522 | |12;stanford-crypto-pbkdf2;187;181;173;184;169;163;172;175;171;169 03:38:52 INFO - PID 7522 | |13;stanford-crypto-sha256-iterative;67;63;64;64;66;64;65;63;65;63 03:38:52 INFO - PID 7522 | __end_tp_report 03:38:52 INFO - PID 7522 | __start_cc_report 03:38:52 INFO - PID 7522 | _x_x_mozilla_cycle_collect,941 03:38:52 INFO - PID 7522 | __end_cc_report 03:38:52 INFO - PID 7522 | __startTimestamp1505126332100__endTimestamp 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | ------- Summary: start ------- 03:38:52 INFO - PID 7522 | Number of tests: 14 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 03:38:52 INFO - PID 7522 | Values: 108.0 108.0 109.0 107.0 109.0 108.0 109.0 108.0 108.0 107.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:117.00 stddev:2.27 (1.9%) stddev-sans-first:2.40 03:38:52 INFO - PID 7522 | Values: 117.0 117.0 117.0 115.0 116.0 116.0 122.0 121.0 117.0 116.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 03:38:52 INFO - PID 7522 | Values: 164.0 161.0 164.0 163.0 164.0 162.0 167.0 166.0 170.0 164.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.48 (2.0%) stddev-sans-first:1.50 03:38:52 INFO - PID 7522 | Values: 75.0 73.0 72.0 73.0 74.0 74.0 72.0 74.0 74.0 77.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:79.50 stddev:2.00 (2.5%) stddev-sans-first:2.11 03:38:52 INFO - PID 7522 | Values: 79.0 78.0 80.0 80.0 79.0 79.0 80.0 79.0 78.0 85.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 03:38:52 INFO - PID 7522 | Values: 112.0 113.0 113.0 113.0 114.0 114.0 113.0 114.0 117.0 114.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:38:52 INFO - PID 7522 | Values: 148.0 150.0 147.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 03:38:52 INFO - PID 7522 | Values: 96.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:1.17 03:38:52 INFO - PID 7522 | Values: 56.0 54.0 53.0 54.0 56.0 53.0 54.0 54.0 55.0 52.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 03:38:52 INFO - PID 7522 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.69 (2.2%) stddev-sans-first:1.76 03:38:52 INFO - PID 7522 | Values: 77.0 75.0 76.0 76.0 75.0 79.0 74.0 79.0 76.0 75.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.00 stddev:6.97 (5.6%) stddev-sans-first:3.94 03:38:52 INFO - PID 7522 | Values: 142.0 123.0 123.0 126.0 123.0 122.0 130.0 124.0 124.0 115.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:7.47 (4.3%) stddev-sans-first:6.38 03:38:52 INFO - PID 7522 | Values: 187.0 181.0 173.0 184.0 169.0 163.0 172.0 175.0 171.0 169.0 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.35 (2.1%) stddev-sans-first:1.05 03:38:52 INFO - PID 7522 | Values: 67.0 63.0 64.0 64.0 66.0 64.0 65.0 63.0 65.0 63.0 03:38:52 INFO - PID 7522 | -------- Summary: end -------- 03:38:52 INFO - PID 7522 | 03:38:52 INFO - PID 7522 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:38:52 INFO - TEST-INFO | 7522: exit 0 03:38:52 INFO - TEST-OK | kraken | took 61162ms 03:38:52 INFO - SUITE-END | took 1170s 03:38:53 INFO - Completed test suite (00:19:30) 03:38:53 INFO - javascript benchmark 03:38:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8440.781354540155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.3375891062874, 3176.332970076284, 3182.665820088889, 3190.728788053016, 3192.0902542775316, 6180.98013827719, 6322.747090116395, 6338.809835704925, 6459.128017717612, 6465.644389558573, 6259.092431597415, 6302.338254483282, 6313.62118272904, 6325.6837158142025, 6348.49212063035, 5778.42215778423, 5816.011278082715, 5838.766449342022, 5895.764169433218, 5965.701714914258, 5878.1476685880525, 5942.554308426886, 5944.346121926606, 5947.6134051286745, 5994.130851026599, 1323.4596857871247, 5754.510866576346, 5766.394528574523, 5847.44449277318, 5934.0, 5721.141828725683, 5752.798652047159, 5818.359980402152, 5850.912236316459, 5851.210086638334, 5737.741801618937, 5760.36635970043, 5809.651420914716, 5821.708914554298, 5823.272090988627, 6256.217972753406, 6276.0, 6277.372262773732, 6328.493720502349, 6358.1734374531015, 6705.731770729214, 6721.529492935497, 6834.043233947202, 6859.965700171517, 6862.691178896962, 6685.264620891698, 6775.288594697535, 6810.387065164109, 6848.863022739517, 6942.0, 6342.524310676671, 6392.328805475405, 6406.551541392105, 6407.967960160169, 6413.6793160341795, 7025.086738723933, 7032.437405007587, 7117.89323160153, 7118.359347658736, 7120.928790712027, 6519.250286217051, 6682.5322227444585, 6691.464682825363, 6765.05289259504, 6778.7288508459105, 6696.732130714814, 6781.8643627127185, 6843.965780171067, 6848.760293389708, 6855.245922948472, 6728.831779205559, 6814.0, 6814.046033555306, 6817.5909445433435, 6818.113645226089, 6768.763093291711, 6782.253952065269, 6799.9800029995895, 6862.588244705334, 6884.173899132136, 5120.590352771769, 5239.502247286502, 5287.894242115136, 5359.0, 5369.382521010056, 4584.747838868894, 4628.514006029319, 4639.605633521189, 4650.162970665245, 4655.301704744315, 5887.293524777054, 5904.498117659961, 5920.230370051866, 5928.940710592925, 5935.169076329317, 6841.657917104125, 6846.938724497711, 6858.245592984767, 6927.618980956096, 6934.410575101072, 5723.685197314105, 5846.473817356373, 5916.852078697981, 5929.199558059693, 5929.881402371929, 5755.65466072037, 5761.942380576224, 5842.152887831241, 5844.824655260349, 5856.648601083949, 6503.219613646393, 6580.670966451658, 6586.769463068769, 6606.735730570724, 6658.700358483783, 6738.124043874265, 6814.046033555405, 6817.216020157745, 6902.930970690229, 6908.516403851782, 6538.869222615616, 6579.835504112435, 6621.27166011748, 6624.966875165594, 6637.933620663732, 6684.364985326386, 6701.0, 6708.295628958889, 6708.329167083252, 6708.966455167693, 6805.0, 6808.93191068083, 6830.7609233676585, 6832.419244364285, 6892.379685828299, 6446.8388290293115, 6558.573692709959, 6563.474922006323, 6645.933540664531, 6648.800535983928, 6554.049662798772, 6635.502337324817, 6637.004449332639, 6656.36764507371, 6662.267150613526, 6504.349565043458, 6509.837254068497, 6545.607263564201, 6565.474762019123, 6594.571352862049, 6339.320080178664, 6456.7740129095255, 6472.805815825533, 6677.6661166940485, 6758.0, 6342.429181373698, 6369.0764839099, 6386.90419643715, 6387.137736405526, 6391.169148010729], "value": 6157.509847087962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.9421840471169, 826.7643721539358, 838.8406202821465, 875.5359659380526, 875.6366108065149, 40515.39226911599, 41292.17415651685, 41382.37926431102, 41400.0, 41409.17181656365, 39339.40990885139, 40170.799146004305, 40172.0, 40265.59734402655, 40266.59733402665, 7766.339861111812, 7871.606419679022, 7872.685092596289, 7876.173001834783, 7882.763517094496, 7730.690772369098, 7848.979632647776, 7850.175731548191, 7851.2933835954755, 7854.607269636495, 7865.646045927919, 7889.3688504919755, 7890.1715319891155, 7890.171531989145, 7891.763247102596, 7785.649645765954, 7830.373570114406, 7830.530168189927, 7838.451308408442, 7845.568493732842, 7699.307062364414, 7705.653245603961, 7719.575423351714, 7719.575423351769, 7761.805954851117, 36911.63088369109, 37059.814700926596, 37103.81448092769, 37157.62842371569, 37173.814130929444, 3589.6051434342203, 3628.564572251347, 3632.0738211756097, 3634.691051260646, 3635.5637323521346, 30427.23931901698, 30529.69470305313, 30557.847210763804, 30562.69437305621, 30686.693133068606, 5213.765380557884, 5235.424103348629, 5264.815731449381, 5269.235960785703, 5280.551153151987, 175608.0, 176510.0, 177082.0, 177499.0, 177699.0, 44531.33203001958, 44649.776751116035, 44652.10695786066, 44684.55315446869, 46513.0, 49581.25628115581, 49643.75178124086, 49744.0, 49774.0, 49780.0, 15413.614659633598, 15505.30226139804, 15539.5338139856, 15571.221438928234, 15758.0, 12749.298788566717, 12773.425195866208, 12786.488540458278, 12847.100702950704, 12850.421731022127, 14304.427822887175, 14343.139411635335, 14395.640108997359, 14579.708405832036, 14700.779488307684, 5716.971415142898, 5726.482482142235, 5781.82654520365, 5853.678047707332, 5881.088431293157, 1005.5726316315537, 1010.3331801011298, 1020.0615433800921, 1021.305512251676, 1027.6916924922643, 22923.541529169324, 22977.310680679606, 23039.53920921606, 23109.768902311098, 23178.42053948631, 1112.4993752811267, 1112.844201811747, 1121.9887801122047, 1129.2772625519674, 1135.1429670598811, 12452.128351015523, 12505.93747031259, 12547.93726031364, 12565.497380104876, 12739.490420383267, 232908.0, 234301.0, 234534.0, 234577.0, 235554.0, 51064.234036489484, 53085.46914530882, 56063.43936560664, 56171.43828561744, 56262.43737562572, 1432.3769160415252, 1440.3158499712554, 1440.7321557029748, 1444.50886698523, 1451.2163431746737, 25946.481070378108, 26112.60831087573, 26146.215613531625, 26433.33916652099, 26600.068997584993, 36317.27365452729, 36705.44941825821, 36716.44925326069, 36738.26523469569, 36804.81597591995, 198993.0, 199335.0, 199680.0, 199691.0, 200308.0, 33367.83316083501, 33436.498452523716, 33668.0, 33808.3238335227, 33857.49213761746, 40171.39742903917, 41530.584694153884, 41589.792051040764, 41886.37170442385, 42098.36852447277, 30684.53973190359, 30801.0, 30932.22669433282, 31625.683743162273, 31720.682793171774, 29967.850160749058, 30227.848860755556, 30303.0, 30398.54402184013, 30924.69075309218, 32327.676723233406, 33332.833335833166, 33355.16612084717, 33601.83199083989, 33742.66257337395, 29579.112626621234, 29684.703152968195, 29790.702092978794, 30112.0, 30263.09210723682, 22098.33704988853, 22285.554288914456, 22370.664440033088, 22442.214522491635, 22750.0], "value": 17008.113537921796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.856471599742, 569.1803802524364, 575.7927146227357, 576.8875069361474, 580.3529065092422, 21520.677189842147, 22094.558108837813, 22150.667739983874, 22206.1117555298, 22232.777672223274, 24018.87990560049, 24672.38319042025, 25081.74918250817, 25166.496670066586, 25178.370540736443, 6302.0861975013595, 6390.840228994289, 6458.483321334282, 6462.25684046336, 6467.417932386084, 6195.132681424581, 6334.144890439778, 6428.646424446653, 6446.548741588067, 6450.903236451457, 6420.5505614607, 6458.095866578683, 6461.386168314003, 6474.579152355105, 6480.935190648081, 6465.8706825863455, 6468.644224567647, 6472.15861937945, 6479.64361960092, 6491.058796474508, 5899.793507227227, 6004.399560044004, 6018.488428483584, 6123.785667501616, 6124.540659450559, 27820.582691259446, 28157.29606759827, 28212.294692632644, 28284.151475455565, 28310.716892831013, 1955.5502234486148, 2001.1995201919203, 2011.2055737983414, 2021.5249416387137, 2022.9595408091757, 18603.81396186048, 18625.161867715986, 19091.0, 19274.518137046547, 19751.901240493706, 2429.720582133042, 2450.7426720194303, 2490.7384724604017, 2492.239866840613, 2499.0253801017616, 118480.0, 124687.0, 131291.0, 137246.31376843152, 137513.0, 14245.358958846877, 14531.564053078424, 14568.719955059927, 14607.44541224196, 14731.852681473263, 22672.886635566716, 22711.659325110137, 22765.430864228194, 22789.88605056964, 22895.542089158458, 9428.387154834914, 9659.0, 9719.201947639567, 9747.512624368754, 9891.159251463707, 8716.694915677921, 8832.38173327861, 8919.464832110094, 8930.776730581787, 8976.41653292534, 9051.094890511027, 9120.635174592942, 9188.0, 9289.72130836076, 9290.767730806783, 2672.0, 2680.584509401046, 2681.2894582935537, 2698.757111859942, 2735.2614794005904, 923.6951805904035, 929.0662883801735, 935.3125452792192, 962.7929995051097, 971.9659811906549, 18290.99399533012, 18475.0, 18748.81251187498, 19211.90394048021, 19352.903235483733, 993.8906720260766, 998.7852611688522, 1002.0730823987782, 1002.3985608634761, 1003.9548220330103, 10646.0, 10675.679729608124, 10696.737495063924, 10747.731306717395, 10850.348979061282, 418187.0, 427621.0, 428085.0, 437060.0, 437101.0, 107026.0, 109169.0, 110115.0, 110878.44560777144, 112201.43899280451, 1007.4005966449951, 1051.8579991701022, 1124.2242852431796, 1147.3804145761196, 1177.1642134084896, 20038.0, 20058.799412005694, 20187.899060504602, 20190.394288171377, 20232.79767202368, 56714.432855670915, 56882.431175687714, 57705.422945770006, 58730.412695872496, 59322.70338648279, 71655.64172179314, 71681.6415917917, 72133.0, 72315.63842180755, 72415.63792181005, 14148.0, 14377.712445750818, 14399.64000899944, 14417.78373324422, 14438.85561144417, 22504.774952250267, 22655.433614159778, 22707.0, 22823.087076516753, 22887.88556057209, 18111.909440452713, 18240.72638910444, 18276.08619569043, 18277.817221828143, 18285.17716702778, 15777.368905243662, 16385.262663179947, 16471.67056658836, 16630.334786608884, 16940.237689303765, 17261.56846078858, 18135.45593632193, 18559.81440185581, 18612.720809188144, 18662.72005919885, 14056.156630601787, 14254.144751314954, 14267.286635667968, 14273.928630356782, 14275.42898284057, 18142.72785908186, 18253.269869205615, 18262.90868545702, 18471.445856624323, 18489.90755046216], "value": 11723.215227665563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.1261473734703, 1395.1141025448837, 1410.4428750643497, 1416.638757116935, 1419.4535103984963, 14821.184834834079, 15669.764953525706, 15673.45142919998, 15681.451149209779, 15693.293801778904, 15214.467493637725, 15248.313825877834, 15288.159151246677, 15335.079895206267, 15349.309281082351, 2660.268426182801, 2790.902318418856, 2791.6510436195476, 2794.6925838157786, 2798.1465652975835, 2229.2643427668913, 2737.835729856205, 2758.7930905182093, 2795.5247607906704, 2796.790240731943, 2312.838101332907, 2323.5585238804574, 2655.787536997045, 2772.7365900239547, 2782.0819129687256, 2610.112561729002, 2650.748178922999, 2659.933501662464, 2666.9599956000675, 2681.1018308866555, 2639.5248855206055, 2650.324167337336, 2652.3501742073317, 2654.376221587925, 2667.2398366465463, 14894.478693245685, 15021.399144034225, 15034.774478382833, 15035.323410446446, 15041.022333548284, 7898.723544675909, 8181.468204566684, 8183.549904755236, 8183.877241841377, 8187.345012399053, 5114.33513643224, 5182.585393168538, 5273.789048438058, 5317.73411329432, 5547.11246200606, 1931.2564662604857, 1941.3205378117545, 1954.9511262218416, 1960.9313674021341, 1961.3919684897728, 26425.207243782716, 26443.338916527242, 26445.47109057808, 26449.0, 26493.0, 7160.0, 7352.889706654404, 7361.153467351216, 7491.213422590658, 7513.361364283987, 16581.83418165827, 17334.133293335282, 17350.0, 19818.20727170926, 19867.701984470244, 7769.6115194240065, 7931.5637639930355, 7937.404694647925, 7976.282134607914, 7979.9601001994615, 7171.605561694053, 7290.781276561712, 7309.232530584319, 7342.412606991428, 7384.815379615553, 4844.273358996179, 4991.201407774739, 4993.300937868701, 5021.6735912165595, 5059.165237735732, 1355.1327150623608, 1382.759928915164, 1383.833939927195, 1395.2884029145007, 1396.8253968253969, 872.5724395046382, 898.7213963671282, 906.5014242166782, 907.1403622573697, 908.8727578139066, 7567.3189412952, 7588.468807183444, 7611.238876112455, 7657.846843063107, 7719.459637825298, 695.8538706871512, 701.6106061136016, 713.2617740638518, 713.3900515059653, 713.5682911838367, 4431.0, 4445.088756804847, 4464.0402313502755, 4468.7710879508395, 4470.642348612103, 20590.0, 21011.8949405252, 21917.890410547847, 22067.558648827253, 22103.778962210494, 21591.2443064492, 21620.243291484723, 21647.13411463524, 21725.565488690452, 21766.0, 10777.191710621735, 10873.347599144077, 10879.945600272107, 10913.83629245562, 10971.83542246867, 7924.722634707758, 8032.236937490929, 8042.758717238492, 8100.554469504234, 8163.918360816316, 18623.255069797055, 18637.813621863606, 18854.24583016664, 18990.715139273198, 19447.61104777925, 19352.612947740683, 19392.12735426881, 19432.0, 19435.90282048637, 19568.804311956697, 10724.195685323475, 10810.945945270223, 10910.672679819618, 10996.945015274872, 11010.284331518425, 13591.728165436438, 13918.443262269397, 13944.16335019902, 13955.372008259856, 13956.930215348859, 11101.389423581457, 11127.276727012719, 11223.66329010131, 11236.269642473213, 11455.59905403307, 10949.343039417661, 11135.777284454103, 11171.776564468502, 11324.773504530029, 11330.150238732293, 8603.483790972561, 8637.179467950535, 8689.0, 8706.695265665672, 8707.738767836974, 6445.806625801233, 6558.376954189344, 6583.407493325623, 6584.572002819993, 6629.933700663125, 6685.39831415175, 6786.796396108125, 6787.762428314985, 6826.214985276558, 6830.487713421613], "value": 6502.919273542179, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.4358846297917, 503.95932399594835, 525.1204232909876, 533.9466053394664, 536.3751229817263, 6310.621362718229, 6333.46165575926, 6345.826022185899, 6383.202099737533, 6406.711697973591, 6190.473809726167, 6239.688015599225, 6267.279262884769, 6299.968500157504, 6333.8099857004245, 5223.608229382802, 5226.163813789794, 5259.815906443256, 5278.181881808326, 5283.735813209324, 4914.3611330527165, 5042.268871013701, 5157.5358217760395, 5224.29472021278, 5259.737013149346, 5002.59979201663, 5006.924896126561, 5025.874353141164, 5063.46833582474, 5064.265681476184, 4978.751062446881, 4979.278004689318, 4985.925211121836, 4995.825146119869, 5007.0, 4392.275274579691, 4467.888302792424, 4482.350059241425, 4484.372187893698, 4493.11289258509, 6090.23872015998, 6106.45041946227, 6114.545281915748, 6129.877402451926, 6159.260888693386, 5706.343770466408, 5717.285339332583, 5725.599208055438, 5728.68492232927, 5731.0, 6581.815273250813, 6587.80236592903, 6598.868022639568, 6612.272650008544, 6628.3371662833815, 4641.257398816173, 4903.338049363361, 4909.754512274372, 4922.803087876517, 4929.309896614477, 6756.763513277061, 6793.728250869959, 6814.897776533307, 6922.8615427692175, 6945.51381403307, 5021.723805190676, 5024.71869673231, 5025.321581586512, 5036.320096786887, 5043.52086551777, 5075.365579302587, 5092.26162206478, 5095.929550097677, 5113.616478764107, 5114.232865070269, 5726.541876649858, 5738.139279108167, 5744.655320680772, 5756.798512052058, 5780.855478612984, 6679.465642748569, 6681.866362672817, 6691.698873550702, 6705.357187489097, 6742.347780031762, 1722.2852516205885, 1747.554373634715, 1765.0292339213381, 1765.540959350578, 1770.8140645232322, 1174.8648905375992, 1221.5297110612478, 1222.9877701222874, 1223.2232532342027, 1236.567201479475, 5701.572382071278, 5723.198752174699, 5780.335261444988, 5782.942170578324, 5783.103618939072, 6700.229473610597, 6711.429528490035, 6716.026176204521, 6760.594364338155, 6837.0, 5653.823278037985, 5656.123300888369, 5701.0, 5712.543301458101, 5732.111522713986, 3554.7689400188906, 3574.946375804365, 3576.3562558739154, 3586.246888153517, 3641.417373220325, 6430.646314452656, 6465.935340646627, 6497.18785151856, 6509.707063182168, 6521.445677117404, 6538.476921846241, 6755.256921738604, 6760.323967603299, 6838.196339500781, 6852.965735171392, 6406.455451286693, 6428.200103970708, 6431.581947173512, 6455.677216139268, 6510.5117116217425, 6740.595564266159, 6740.730370785113, 6746.426553742791, 6749.603890618956, 6771.0, 6603.085105319404, 6634.767783127568, 6680.665966701548, 6696.933030669631, 6699.908069867034, 6457.773977910939, 6463.967680161757, 6490.383413575702, 6494.7077381517, 6522.934770652422, 4942.047891083074, 4945.530174633404, 5032.169692000925, 5043.394792624762, 5044.470330615232, 6500.219973603198, 6571.539992200691, 6687.7596005338755, 6756.628385438848, 6828.507594727789, 6362.554621176473, 6548.443382312556, 6560.606363618198, 6582.934170658232, 6614.669266536558, 6509.511786615928, 6595.340465953366, 6601.669916504252, 6603.250138713341, 6619.50353723463, 6463.838404039937, 6466.61200327963, 6467.902981455376, 6471.835069687313, 6489.0, 6527.445167160845, 6531.3468653134305, 6567.27759946396, 6579.342065793574, 6607.900881486686, 6290.842728931813, 6291.559590828598, 6298.149749783721, 6421.229452465547, 6429.421352078335], "value": 5079.060089195478, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.1006078829987, 893.7631527645175, 914.8627705844123, 915.3866909170855, 927.4852456886427, 17179.226934787934, 17584.38454654084, 17612.29550817967, 17624.911875440604, 17660.205290761915, 16931.06879121648, 17043.403480878173, 17055.658886822257, 17085.31658733652, 17150.485485435427, 942.208544822349, 965.6137544982029, 967.0184762466102, 967.4340510801189, 969.0890562870914, 966.463612694954, 981.6711401680445, 982.0277924854414, 983.5868935047297, 984.1044649369076, 993.8658281132027, 997.5909876950452, 1018.3024628129717, 1030.562011145264, 1034.5861655337849, 1010.9494525273743, 1027.2706378471294, 1028.2236911132047, 1028.228828378716, 1028.9228307876901, 731.1664702239451, 743.5501521579421, 744.0178963767829, 751.3012898004853, 757.2124990010383, 20149.09329080195, 20373.898130509253, 20430.795692043037, 20458.283960061326, 20465.693014604793, 21046.47383815417, 21177.258795942224, 22028.33914982553, 22145.889270553544, 22160.778392216034, 16866.91566542172, 17032.063236521986, 17106.828931710646, 17162.31350745981, 17313.7402938956, 3698.204885949534, 3731.589525152231, 3731.9067023324365, 3732.794696291703, 3733.197362567034, 100331.0, 133238.33380833032, 134470.0, 135938.0, 136665.316673416, 16850.831491684927, 16970.830291697173, 17177.65644687099, 17192.656146876994, 17197.1401429928, 29156.0, 29320.26699332534, 29920.102396928127, 29963.550546741815, 30134.849325753232, 9236.8614470783, 9359.859602105973, 9371.484568348806, 9374.203192728695, 9392.436453812794, 4347.391365208873, 4377.4965878923695, 4508.301213311942, 4518.864434066983, 4520.434945631796, 5334.226537152092, 5346.144616861284, 5438.401775804658, 5442.782288708487, 5454.91817622736, 1034.5861655337926, 1060.8567843341204, 1068.4550879051585, 1069.2301542889106, 1072.3887384190937, 686.6017709728345, 699.7830672491544, 701.9403350715246, 707.536563550875, 718.2279050021248, 10815.86433424479, 11563.42182890869, 11651.184417090892, 12330.383480825923, 12362.814557781641, 677.4241894389828, 687.412262515552, 697.052009267396, 699.2622782964022, 702.1784512120831, 5833.562482813806, 5851.970740146272, 5951.5238780897425, 5951.791687290924, 5998.850028749316, 115600.42199789116, 115615.42192288984, 117711.41144294223, 118105.40947295209, 119873.0, 100220.49889750505, 101305.0, 101690.4915475418, 106390.0, 107067.0, 91363.0, 93273.0, 94510.0, 96796.51601741946, 97034.51482742683, 10997.0, 11015.889841101487, 11094.500747466222, 11127.221094523306, 11235.101191904465, 42836.14327713366, 45059.54940450554, 45149.0, 45713.08573828438, 46160.53839461562, 56524.71737641285, 56825.431745683665, 57178.7141064292, 57270.0, 58762.70618646879, 15622.531324060297, 15867.0, 15996.680066398374, 16079.196040198178, 16110.67778644444, 17735.82264177393, 17870.106494675474, 17922.5519362017, 18029.188686508875, 18047.819521804613, 15984.0, 16126.0, 16145.0, 16424.589385265463, 16444.342226310815, 16268.674626507167, 16457.094859782348, 16490.75263871019, 16624.50126496207, 16634.3346266148, 14354.928225358806, 14484.130952142905, 14491.637709056937, 14554.12675239489, 14698.63253418673, 11592.710182245512, 11634.70913227176, 11766.647000589996, 11806.527738890349, 11857.822132668189, 12732.936335318263, 12777.680557986125, 12799.720027997126, 12830.615081547568, 13020.41408136655], "value": 8918.068577626696, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.8000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 109.0, 107.0, 109.0, 108.0, 109.0, 108.0, 108.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 115.0, 116.0, 116.0, 122.0, 121.0, 117.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 163.0, 164.0, 162.0, 167.0, 166.0, 170.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 73.0, 74.0, 74.0, 72.0, 74.0, 74.0, 77.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 80.0, 79.0, 79.0, 80.0, 79.0, 78.0, 85.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 117.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 56.0, 53.0, 54.0, 54.0, 55.0, 52.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 76.0, 75.0, 79.0, 74.0, 79.0, 76.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 123.0, 123.0, 126.0, 123.0, 122.0, 130.0, 124.0, 124.0, 115.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 181.0, 173.0, 184.0, 169.0, 163.0, 172.0, 175.0, 171.0, 169.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 66.0, 64.0, 65.0, 63.0, 65.0, 63.0], "value": 64.4, "unit": "score"}]}]} 03:38:53 INFO - Return code: 0 03:38:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:53 INFO - # TBPL SUCCESS # 03:38:53 INFO - Running post-action listener: _package_coverage_data 03:38:53 INFO - Running post-action listener: _resource_record_post_action 03:38:53 INFO - [mozharness: 2017-09-11 10:38:53.370855Z] Finished run-tests step (success) 03:38:53 INFO - Running post-run listener: _resource_record_post_run 03:38:53 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305704960; Read time: 16; Write time: 193424 03:38:53 INFO - TinderboxPrint: CPU usage
13.1% 03:38:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:38:53 INFO - TinderboxPrint: I/O write bytes / time
305,704,960 / 193,424 03:38:53 INFO - TinderboxPrint: CPU idle
8,224.5 (86.9%) 03:38:53 INFO - TinderboxPrint: CPU user
1,191.2 (12.6%) 03:38:53 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12632064; Read time: 0; Write time: 2512 03:38:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:38:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293072896; Read time: 16; Write time: 190912 03:38:54 INFO - Running post-run listener: _upload_blobber_files 03:38:54 INFO - Blob upload gear active. 03:38:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:38:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:01 INFO - (blobuploader) - INFO - Done attempting. 03:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:02 INFO - (blobuploader) - INFO - Done attempting. 03:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:03 INFO - (blobuploader) - INFO - Done attempting. 03:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:04 INFO - (blobuploader) - INFO - Done attempting. 03:39:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:04 INFO - Return code: 0 03:39:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6851df968a00775ad53e46806b2015303a085d1ccef6a8a6ac06dc4699f6194b69803122d07646fb7b247d7891691640befbc3646d931d273c9919b2109375b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a3180088ec71b3232c494674f47e3c8849112765f4fa92c8e0c76b3c416f5ca9fbb21e5a51ff641c28cc2c85040c6e2244a3d213e1bf733cf5454cc3248648b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f81b4fe05de31c26cb194f58fb9feca36a6dc48c08c6da90c97be5c8444c728397887a3a67c1704c5e99f4fceec34fd1533f5ce87ad14ffd2b3dae0b2481aae2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/484faafbefdc1e6c0f97dcedcf1818857607cfc34909732167fdd39cfb8d384127bd7a0737884a8bb45aff9d28d2c084cf5ebe2b34ead8aa1698215cb4e81b58"} 03:39:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:04 INFO - Contents: 03:39:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6851df968a00775ad53e46806b2015303a085d1ccef6a8a6ac06dc4699f6194b69803122d07646fb7b247d7891691640befbc3646d931d273c9919b2109375b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a3180088ec71b3232c494674f47e3c8849112765f4fa92c8e0c76b3c416f5ca9fbb21e5a51ff641c28cc2c85040c6e2244a3d213e1bf733cf5454cc3248648b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f81b4fe05de31c26cb194f58fb9feca36a6dc48c08c6da90c97be5c8444c728397887a3a67c1704c5e99f4fceec34fd1533f5ce87ad14ffd2b3dae0b2481aae2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/484faafbefdc1e6c0f97dcedcf1818857607cfc34909732167fdd39cfb8d384127bd7a0737884a8bb45aff9d28d2c084cf5ebe2b34ead8aa1698215cb4e81b58"} 03:39:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:04 INFO - Copying logs to upload dir... 03:39:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.064709 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-11 03:39:04.711959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:04.717715) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6851df968a00775ad53e46806b2015303a085d1ccef6a8a6ac06dc4699f6194b69803122d07646fb7b247d7891691640befbc3646d931d273c9919b2109375b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a3180088ec71b3232c494674f47e3c8849112765f4fa92c8e0c76b3c416f5ca9fbb21e5a51ff641c28cc2c85040c6e2244a3d213e1bf733cf5454cc3248648b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f81b4fe05de31c26cb194f58fb9feca36a6dc48c08c6da90c97be5c8444c728397887a3a67c1704c5e99f4fceec34fd1533f5ce87ad14ffd2b3dae0b2481aae2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/484faafbefdc1e6c0f97dcedcf1818857607cfc34909732167fdd39cfb8d384127bd7a0737884a8bb45aff9d28d2c084cf5ebe2b34ead8aa1698215cb4e81b58"} build_url:https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6851df968a00775ad53e46806b2015303a085d1ccef6a8a6ac06dc4699f6194b69803122d07646fb7b247d7891691640befbc3646d931d273c9919b2109375b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a3180088ec71b3232c494674f47e3c8849112765f4fa92c8e0c76b3c416f5ca9fbb21e5a51ff641c28cc2c85040c6e2244a3d213e1bf733cf5454cc3248648b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f81b4fe05de31c26cb194f58fb9feca36a6dc48c08c6da90c97be5c8444c728397887a3a67c1704c5e99f4fceec34fd1533f5ce87ad14ffd2b3dae0b2481aae2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/484faafbefdc1e6c0f97dcedcf1818857607cfc34909732167fdd39cfb8d384127bd7a0737884a8bb45aff9d28d2c084cf5ebe2b34ead8aa1698215cb4e81b58"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:04.796783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:04.797255) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505125105.635473-1030334321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:04.817872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 03:39:04.818175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 03:39:04.818576) ========= ========= Total master_lag: 0.18 =========