builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-078 starttime: 1504954886.38 results: success (0) revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.383074) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.383501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.383774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.532231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.532603) ========= 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=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 04:01: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.9M=0s 2017-09-09 04:01:26 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.700741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.701085) ========= 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=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:26.757904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-09-09 04:01:26.758241) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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 e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 04:01:26,781 truncating revision to first 12 chars 2017-09-09 04:01:26,781 Setting DEBUG logging. 2017-09-09 04:01:26,781 attempt 1/10 2017-09-09 04:01:26,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0d88cd771d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 04:01:28,095 unpacking tar archive at: mozilla-central-e0d88cd771d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.591414 ========= master_lag: 1.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-09-09 04:01:29.920968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:29.921317) ========= script_repo_revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:29.921773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:29.928183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:01:30.051456) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-09 04:01:30.051732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:30 INFO - MultiFileLogger online at 20170909 04:01:30 in /builds/slave/test 04:01:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:01:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:30 INFO - {'append_to_log': False, 04:01:30 INFO - 'base_work_dir': '/builds/slave/test', 04:01:30 INFO - 'blob_upload_branch': 'Firefox', 04:01:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:30 INFO - 'branch': 'Firefox', 04:01:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:30 INFO - 'code_coverage': False, 04:01:30 INFO - 'config_files': ('talos/linux_config.py',), 04:01:30 INFO - 'default_actions': ('clobber', 04:01:30 INFO - 'read-buildbot-config', 04:01:30 INFO - 'download-and-extract', 04:01:30 INFO - 'populate-webroot', 04:01:30 INFO - 'create-virtualenv', 04:01:30 INFO - 'install', 04:01:30 INFO - 'setup-mitmproxy', 04:01:30 INFO - 'run-tests'), 04:01:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:30 INFO - 'disable_ccov_upload': False, 04:01:30 INFO - 'disable_stylo': False, 04:01:30 INFO - 'download_minidump_stackwalk': True, 04:01:30 INFO - 'download_symbols': 'ondemand', 04:01:30 INFO - 'enable_stylo': False, 04:01:30 INFO - 'enable_webrender': False, 04:01:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:01:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:30 INFO - 'gecko_profile': False, 04:01:30 INFO - 'gecko_profile_interval': 0, 04:01:30 INFO - 'installer_path': 'installer.exe', 04:01:30 INFO - 'log_level': 'info', 04:01:30 INFO - 'log_name': 'talos', 04:01:30 INFO - 'log_to_console': True, 04:01:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:30 INFO - 'opt_config_files': (), 04:01:30 INFO - 'pip_index': False, 04:01:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:01:30 INFO - 'system_bits': '32', 04:01:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:30 INFO - 'title': 'talos-linux64-ix-078', 04:01:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:30 INFO - 'use_talos_json': True, 04:01:30 INFO - 'verify': 'False', 04:01:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:30 INFO - 'work_dir': 'build'} 04:01:30 INFO - [mozharness: 2017-09-09 11:01:30.213065Z] Running clobber step. 04:01:30 INFO - Running pre-action listener: _resource_record_pre_action 04:01:30 INFO - Running main action method: clobber 04:01:30 INFO - rmtree: /builds/slave/test/build 04:01:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:31 INFO - Running post-action listener: _resource_record_post_action 04:01:31 INFO - [mozharness: 2017-09-09 11:01:31.241421Z] Finished clobber step (success) 04:01:31 INFO - [mozharness: 2017-09-09 11:01:31.241519Z] Running read-buildbot-config step. 04:01:31 INFO - Running pre-action listener: _resource_record_pre_action 04:01:31 INFO - Running main action method: read_buildbot_config 04:01:31 INFO - Using buildbot properties: 04:01:31 INFO - { 04:01:31 INFO - "project": "", 04:01:31 INFO - "product": "firefox", 04:01:31 INFO - "who": "archaeopteryx@coole-files.de", 04:01:31 INFO - "installer_path": "public/build/target.tar.bz2", 04:01:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:01:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:01:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:01:31 INFO - "stage_platform": "linux64-pgo", 04:01:31 INFO - "basedir": "/builds/slave/test", 04:01:31 INFO - "buildnumber": 1, 04:01:31 INFO - "platform": "ubuntu64_hw", 04:01:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:01:31 INFO - "slavebuilddir": "test", 04:01:31 INFO - "taskId": "dW_8o0k6S32hefaABe3VAQ", 04:01:31 INFO - "branch": "mozilla-central", 04:01:31 INFO - "script_repo_revision": "production", 04:01:31 INFO - "revision": "e0d88cd771d6791be4eaed4ada9315f4b26e2ad1", 04:01:31 INFO - "slavename": "talos-linux64-ix-078", 04:01:31 INFO - "repo_path": "mozilla-central" 04:01:31 INFO - } 04:01:31 INFO - Finding installer, test and symbols from parent task. 04:01:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dW_8o0k6S32hefaABe3VAQ'}, attempt #1 04:01:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dW_8o0k6S32hefaABe3VAQ'}, attempt #1 04:01:32 INFO - Task dependencies: HkGfihTsQnqFjbjqcJcq_w 04:01:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w'}, attempt #1 04:01:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json 04:01:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip 04:01:32 INFO - Running post-action listener: _resource_record_post_action 04:01:32 INFO - [mozharness: 2017-09-09 11:01:32.648048Z] Finished read-buildbot-config step (success) 04:01:32 INFO - [mozharness: 2017-09-09 11:01:32.648265Z] Running download-and-extract step. 04:01:32 INFO - Running pre-action listener: _resource_record_pre_action 04:01:32 INFO - Running main action method: download_and_extract 04:01:32 INFO - mkdir: /builds/slave/test/build/tests 04:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:32 INFO - trying https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json 04:01:32 INFO - Downloading https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:01:33 INFO - Downloaded 989 bytes. 04:01:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:01:33 INFO - Using the following test package requirements: 04:01:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:01:33 INFO - u'common': [u'target.common.tests.zip'], 04:01:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:01:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:01:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:01:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:01:33 INFO - u'mozbase': [u'target.common.tests.zip'], 04:01:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:01:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:01:33 INFO - u'web-platform': [u'target.common.tests.zip', 04:01:33 INFO - u'target.web-platform.tests.tar.gz'], 04:01:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:01:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:01:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip 04:01:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:01:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.common.tests.zip into memory 04:01:34 INFO - Content-Length response header: 55691549 04:01:34 INFO - Bytes received: 55691549 04:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip 04:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.talos.tests.zip into memory 04:01:45 INFO - Content-Length response header: 14497963 04:01:45 INFO - Bytes received: 14497963 04:01: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')]} 04:01:46 INFO - trying https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:46 INFO - Downloading https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:01:47 INFO - Downloaded 63617828 bytes. 04:01:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:47 INFO - mkdir: /builds/slave/test/properties 04:01:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:47 INFO - Contents: 04:01:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 04:01:47 INFO - Running post-action listener: _resource_record_post_action 04:01:47 INFO - Running post-action listener: find_tests_for_verification 04:01:47 INFO - Running post-action listener: set_extra_try_arguments 04:01:47 INFO - [mozharness: 2017-09-09 11:01:47.495664Z] Finished download-and-extract step (success) 04:01:47 INFO - [mozharness: 2017-09-09 11:01:47.495775Z] Running populate-webroot step. 04:01:47 INFO - Running pre-action listener: _resource_record_pre_action 04:01:47 INFO - Running main action method: populate_webroot 04:01:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['tresize', 04:01:47 INFO - 'tcanvasmark']}, 04:01:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['dromaeo_css', 04:01:47 INFO - 'kraken']}, 04:01:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'tests': ['damp', 'tps']}, 04:01:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['damp', 'tps']}, 04:01:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['dromaeo_dom']}, 04:01:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:01:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['basic_compositor_video', 04:01:47 INFO - 'glvideo']}, 04:01:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:01:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['ts_paint_webext', 04:01:47 INFO - 'tp5o_webext']}, 04:01:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:47 INFO - 'ts_paint', 04:01:47 INFO - 'tpaint', 04:01:47 INFO - 'sessionrestore', 04:01:47 INFO - 'sessionrestore_many_windows', 04:01:47 INFO - 'sessionrestore_no_auto_restore', 04:01:47 INFO - 'tabpaint']}, 04:01:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['a11yr', 04:01:47 INFO - 'ts_paint', 04:01:47 INFO - 'tpaint', 04:01:47 INFO - 'sessionrestore', 04:01:47 INFO - 'sessionrestore_many_windows', 04:01:47 INFO - 'sessionrestore_no_auto_restore', 04:01:47 INFO - 'tabpaint']}, 04:01:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:01:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:01:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['bloom_basic_singleton']}, 04:01:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['bloom_basic']}, 04:01:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:47 INFO - 'tsvgr_opacity', 04:01:47 INFO - 'tart', 04:01:47 INFO - 'tscrollx', 04:01:47 INFO - 'tsvg_static']}, 04:01:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['tsvgx', 04:01:47 INFO - 'tsvgr_opacity', 04:01:47 INFO - 'tart', 04:01:47 INFO - 'tscrollx', 04:01:47 INFO - 'tsvg_static']}, 04:01:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:01:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo'], 04:01:47 INFO - 'tests': ['tp5o']}, 04:01:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:47 INFO - 'talos_options': ['--mitmproxy', 04:01:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:47 INFO - '--firstNonBlankPaint'], 04:01:47 INFO - 'tests': ['tp6_google', 04:01:47 INFO - 'tp6_youtube', 04:01:47 INFO - 'tp6_amazon', 04:01:47 INFO - 'tp6_facebook']}, 04:01:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo', 04:01:47 INFO - '--mitmproxy', 04:01:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:47 INFO - '--firstNonBlankPaint'], 04:01:47 INFO - 'tests': ['tp6_google', 04:01:47 INFO - 'tp6_youtube', 04:01:47 INFO - 'tp6_amazon', 04:01:47 INFO - 'tp6_facebook']}, 04:01:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:01:47 INFO - 'talos_options': ['--stylo-threads=1', 04:01:47 INFO - '--mitmproxy', 04:01:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:01:47 INFO - '--firstNonBlankPaint'], 04:01:47 INFO - 'tests': ['tp6_google', 04:01:47 INFO - 'tp6_youtube', 04:01:47 INFO - 'tp6_amazon', 04:01:47 INFO - 'tp6_facebook']}, 04:01:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--xperf_path', 04:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:47 INFO - 'tests': ['tp5n']}, 04:01:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:01:47 INFO - 'talos_options': ['--disable-stylo', 04:01:47 INFO - '--xperf_path', 04:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:47 INFO - 'tests': ['tp5n']}}} 04:01:47 INFO - Running post-action listener: _resource_record_post_action 04:01:47 INFO - [mozharness: 2017-09-09 11:01:47.512371Z] Finished populate-webroot step (success) 04:01:47 INFO - [mozharness: 2017-09-09 11:01:47.512476Z] Running create-virtualenv step. 04:01:47 INFO - Running pre-action listener: _resource_record_pre_action 04:01:47 INFO - Running main action method: create_virtualenv 04:01:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:01:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:01:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:48 INFO - Installing pip...............done. 04:01:48 INFO - Return code: 0 04:01:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:01:48 INFO - Reading from file tmpfile_stdout 04:01:48 INFO - Output received: 04:01:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:01:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:48 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:48 INFO - Using env: {'DISPLAY': ':0', 04:01:48 INFO - 'HOME': '/home/cltbld', 04:01:48 INFO - 'LANG': 'en_US.UTF-8', 04:01:48 INFO - 'LANGUAGE': 'en_US:en', 04:01:48 INFO - 'LOGNAME': 'cltbld', 04:01:48 INFO - 'MAIL': '/var/mail/cltbld', 04:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:48 INFO - 'MOZ_NO_REMOTE': '1', 04:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:48 INFO - 'NO_EM_RESTART': '1', 04:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:48 INFO - 'PWD': '/builds/slave/test', 04:01:48 INFO - 'SHELL': '/bin/bash', 04:01:48 INFO - 'SHLVL': '1', 04:01:48 INFO - 'TERM': 'linux', 04:01:48 INFO - 'TMOUT': '86400', 04:01:48 INFO - 'USER': 'cltbld', 04:01:48 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:48 INFO - '_': '/tools/buildbot/bin/python'} 04:01:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:01:49 INFO - Downloading/unpacking pip>=1.5 04:01:49 INFO - Running setup.py egg_info for package pip 04:01:49 INFO - warning: no files found matching 'pip/cacert.pem' 04:01:49 INFO - warning: no files found matching '*.html' under directory 'docs' 04:01:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:01:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:01:49 INFO - Installing collected packages: pip 04:01:49 INFO - Found existing installation: pip 1.1 04:01:49 INFO - Uninstalling pip: 04:01:49 INFO - Successfully uninstalled pip 04:01:49 INFO - Running setup.py install for pip 04:01:49 INFO - warning: no files found matching 'pip/cacert.pem' 04:01:49 INFO - warning: no files found matching '*.html' under directory 'docs' 04:01:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:01:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:01:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:01:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:01:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:01:49 INFO - Successfully installed pip 04:01:49 INFO - Cleaning up... 04:01:49 INFO - Return code: 0 04:01:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', '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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:01: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 psutil>=3.1.1 04:01:49 INFO - Using env: {'DISPLAY': ':0', 04:01:49 INFO - 'HOME': '/home/cltbld', 04:01:49 INFO - 'LANG': 'en_US.UTF-8', 04:01:49 INFO - 'LANGUAGE': 'en_US:en', 04:01:49 INFO - 'LOGNAME': 'cltbld', 04:01:49 INFO - 'MAIL': '/var/mail/cltbld', 04:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:49 INFO - 'MOZ_NO_REMOTE': '1', 04:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:49 INFO - 'NO_EM_RESTART': '1', 04:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:49 INFO - 'PWD': '/builds/slave/test', 04:01:49 INFO - 'SHELL': '/bin/bash', 04:01:49 INFO - 'SHLVL': '1', 04:01:49 INFO - 'TERM': 'linux', 04:01:49 INFO - 'TMOUT': '86400', 04:01:49 INFO - 'USER': 'cltbld', 04:01:49 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:49 INFO - '_': '/tools/buildbot/bin/python'} 04:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:49 INFO - Downloading/unpacking psutil>=3.1.1 04:01: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 04:01: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 04:01: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 04:01: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 04:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:51 INFO - Installing collected packages: psutil 04:01:51 INFO - Running setup.py install for psutil 04:01:51 INFO - building 'psutil._psutil_linux' extension 04:01:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:01:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:01:51 INFO - building 'psutil._psutil_posix' extension 04:01:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:01:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:51 INFO - Successfully installed psutil 04:01:51 INFO - Cleaning up... 04:01:51 INFO - Return code: 0 04:01:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:01: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 mozsystemmonitor==0.3 04:01:51 INFO - Using env: {'DISPLAY': ':0', 04:01:51 INFO - 'HOME': '/home/cltbld', 04:01:51 INFO - 'LANG': 'en_US.UTF-8', 04:01:51 INFO - 'LANGUAGE': 'en_US:en', 04:01:51 INFO - 'LOGNAME': 'cltbld', 04:01:51 INFO - 'MAIL': '/var/mail/cltbld', 04:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:51 INFO - 'MOZ_NO_REMOTE': '1', 04:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:51 INFO - 'NO_EM_RESTART': '1', 04:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:51 INFO - 'PWD': '/builds/slave/test', 04:01:51 INFO - 'SHELL': '/bin/bash', 04:01:51 INFO - 'SHLVL': '1', 04:01:51 INFO - 'TERM': 'linux', 04:01:51 INFO - 'TMOUT': '86400', 04:01:51 INFO - 'USER': 'cltbld', 04:01:51 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:51 INFO - '_': '/tools/buildbot/bin/python'} 04:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:01: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 04:01: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 04:01: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 04:01: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 04:01:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:01:53 INFO - Installing collected packages: mozsystemmonitor 04:01:53 INFO - Running setup.py install for mozsystemmonitor 04:01:53 INFO - Successfully installed mozsystemmonitor 04:01:53 INFO - Cleaning up... 04:01:54 INFO - Return code: 0 04:01:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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', '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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:01: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 jsonschema==2.5.1 04:01:54 INFO - Using env: {'DISPLAY': ':0', 04:01:54 INFO - 'HOME': '/home/cltbld', 04:01:54 INFO - 'LANG': 'en_US.UTF-8', 04:01:54 INFO - 'LANGUAGE': 'en_US:en', 04:01:54 INFO - 'LOGNAME': 'cltbld', 04:01:54 INFO - 'MAIL': '/var/mail/cltbld', 04:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:54 INFO - 'MOZ_NO_REMOTE': '1', 04:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:54 INFO - 'NO_EM_RESTART': '1', 04:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:54 INFO - 'PWD': '/builds/slave/test', 04:01:54 INFO - 'SHELL': '/bin/bash', 04:01:54 INFO - 'SHLVL': '1', 04:01:54 INFO - 'TERM': 'linux', 04:01:54 INFO - 'TMOUT': '86400', 04:01:54 INFO - 'USER': 'cltbld', 04:01:54 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:54 INFO - '_': '/tools/buildbot/bin/python'} 04:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:54 INFO - Downloading/unpacking jsonschema==2.5.1 04:01: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 04:01: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 04:01: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 04:01: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 04:01:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:56 INFO - warning: no files found matching '*.txt' 04:01:56 INFO - no previously-included directories found matching 'build' 04:01:56 INFO - no previously-included directories found matching 'dist' 04:01:56 INFO - no previously-included directories found matching '.git*' 04:01:56 INFO - Installing collected packages: jsonschema, functools32 04:01:56 INFO - Running setup.py install for functools32 04:01:56 INFO - warning: no files found matching '*.txt' 04:01:56 INFO - no previously-included directories found matching 'build' 04:01:56 INFO - no previously-included directories found matching 'dist' 04:01:56 INFO - no previously-included directories found matching '.git*' 04:01:56 INFO - Successfully installed jsonschema functools32 04:01:56 INFO - Cleaning up... 04:01:56 INFO - Return code: 0 04:01:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:56 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:01:56 INFO - Using env: {'DISPLAY': ':0', 04:01:56 INFO - 'HOME': '/home/cltbld', 04:01:56 INFO - 'LANG': 'en_US.UTF-8', 04:01:56 INFO - 'LANGUAGE': 'en_US:en', 04:01:56 INFO - 'LOGNAME': 'cltbld', 04:01:56 INFO - 'MAIL': '/var/mail/cltbld', 04:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:56 INFO - 'MOZ_NO_REMOTE': '1', 04:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:56 INFO - 'NO_EM_RESTART': '1', 04:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:56 INFO - 'PWD': '/builds/slave/test', 04:01:56 INFO - 'SHELL': '/bin/bash', 04:01:56 INFO - 'SHLVL': '1', 04:01:56 INFO - 'TERM': 'linux', 04:01:56 INFO - 'TMOUT': '86400', 04:01:56 INFO - 'USER': 'cltbld', 04:01:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:56 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:01:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:01:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - Downloading docopt-0.6.1.tar.gz 04:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:59 INFO - Running setup.py install for blobuploader 04:01:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:59 INFO - Running setup.py install for requests 04:01:59 INFO - Running setup.py install for docopt 04:01:59 INFO - Successfully installed blobuploader requests docopt 04:01:59 INFO - Cleaning up... 04:01:59 INFO - Return code: 0 04:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:59 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:59 INFO - Using env: {'DISPLAY': ':0', 04:01:59 INFO - 'HOME': '/home/cltbld', 04:01:59 INFO - 'LANG': 'en_US.UTF-8', 04:01:59 INFO - 'LANGUAGE': 'en_US:en', 04:01:59 INFO - 'LOGNAME': 'cltbld', 04:01:59 INFO - 'MAIL': '/var/mail/cltbld', 04:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:59 INFO - 'MOZ_NO_REMOTE': '1', 04:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:59 INFO - 'NO_EM_RESTART': '1', 04:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:59 INFO - 'PWD': '/builds/slave/test', 04:01:59 INFO - 'SHELL': '/bin/bash', 04:01:59 INFO - 'SHLVL': '1', 04:01:59 INFO - 'TERM': 'linux', 04:01:59 INFO - 'TMOUT': '86400', 04:01:59 INFO - 'USER': 'cltbld', 04:01:59 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:59 INFO - '_': '/tools/buildbot/bin/python'} 04:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:59 INFO - Running setup.py (path:/tmp/pip-oBWgwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:59 INFO - Running setup.py (path:/tmp/pip-2aOUo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:59 INFO - Running setup.py (path:/tmp/pip-r0jxv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:00 INFO - Running setup.py (path:/tmp/pip-ZHZbaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:00 INFO - Running setup.py (path:/tmp/pip-RBqrHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:00 INFO - Running setup.py (path:/tmp/pip-6EWsZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:00 INFO - Running setup.py (path:/tmp/pip-mygKnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:00 INFO - Running setup.py (path:/tmp/pip-My8ivo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:00 INFO - Running setup.py (path:/tmp/pip-aDKZK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:00 INFO - Running setup.py (path:/tmp/pip-TnPtVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:00 INFO - Running setup.py (path:/tmp/pip-jhEloQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:00 INFO - Running setup.py (path:/tmp/pip-LeVfzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:00 INFO - Running setup.py (path:/tmp/pip-WrkzZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:00 INFO - Running setup.py (path:/tmp/pip-wW1nIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:00 INFO - Running setup.py (path:/tmp/pip-dMkYaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:00 INFO - Running setup.py (path:/tmp/pip-BWbO8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:00 INFO - Running setup.py (path:/tmp/pip-VMfaHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:01 INFO - Running setup.py install for manifestparser 04:02:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Running setup.py install for mozcrash 04:02:01 INFO - Running setup.py install for mozdebug 04:02:01 INFO - Running setup.py install for mozdevice 04:02:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Running setup.py install for mozfile 04:02:01 INFO - Running setup.py install for mozhttpd 04:02:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Running setup.py install for mozinfo 04:02:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Running setup.py install for mozInstall 04:02:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:01 INFO - Running setup.py install for mozleak 04:02:01 INFO - Running setup.py install for mozlog 04:02:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Running setup.py install for moznetwork 04:02:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Running setup.py install for mozprocess 04:02:02 INFO - Running setup.py install for mozprofile 04:02:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Running setup.py install for mozrunner 04:02:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Running setup.py install for mozscreenshot 04:02:02 INFO - Running setup.py install for moztest 04:02:02 INFO - Running setup.py install for mozversion 04:02:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:02 INFO - Cleaning up... 04:02:02 INFO - Return code: 0 04:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02: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')]} 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:02:02 INFO - Using env: {'DISPLAY': ':0', 04:02:02 INFO - 'HOME': '/home/cltbld', 04:02:02 INFO - 'LANG': 'en_US.UTF-8', 04:02:02 INFO - 'LANGUAGE': 'en_US:en', 04:02:02 INFO - 'LOGNAME': 'cltbld', 04:02:02 INFO - 'MAIL': '/var/mail/cltbld', 04:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:02 INFO - 'MOZ_NO_REMOTE': '1', 04:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:02 INFO - 'NO_EM_RESTART': '1', 04:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:02 INFO - 'PWD': '/builds/slave/test', 04:02:02 INFO - 'SHELL': '/bin/bash', 04:02:02 INFO - 'SHLVL': '1', 04:02:02 INFO - 'TERM': 'linux', 04:02:02 INFO - 'TMOUT': '86400', 04:02:02 INFO - 'USER': 'cltbld', 04:02:02 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:02 INFO - '_': '/tools/buildbot/bin/python'} 04:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:03 INFO - Running setup.py (path:/tmp/pip-MvUD0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:03 INFO - Running setup.py (path:/tmp/pip-nfVJH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:03 INFO - Running setup.py (path:/tmp/pip-Ki0NvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:03 INFO - Running setup.py (path:/tmp/pip-ZXCWjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:03 INFO - Running setup.py (path:/tmp/pip-B5E92M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:03 INFO - Running setup.py (path:/tmp/pip-QATn3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:03 INFO - Running setup.py (path:/tmp/pip-ihjB7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:03 INFO - Running setup.py (path:/tmp/pip-7FH9tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:03 INFO - Running setup.py (path:/tmp/pip-af3lr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:03 INFO - Running setup.py (path:/tmp/pip-VY6T8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:03 INFO - Running setup.py (path:/tmp/pip-C2RKP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:03 INFO - Running setup.py (path:/tmp/pip-_b8Asw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:03 INFO - Running setup.py (path:/tmp/pip-CpsZVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:03 INFO - Running setup.py (path:/tmp/pip-hF5FcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:04 INFO - Running setup.py (path:/tmp/pip-qvolG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:04 INFO - Running setup.py (path:/tmp/pip-ysYiBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:04 INFO - Running setup.py (path:/tmp/pip-7J1Tbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:02:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:05 INFO - Downloading blessings-1.6.tar.gz 04:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:05 INFO - Installing collected packages: blessings 04:02:05 INFO - Running setup.py install for blessings 04:02:05 INFO - Successfully installed blessings 04:02:05 INFO - Cleaning up... 04:02:05 INFO - Return code: 0 04:02:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:05 INFO - Reading from file tmpfile_stdout 04:02:05 INFO - Current package versions: 04:02:05 INFO - argparse == 1.2.1 04:02:05 INFO - blessings == 1.6 04:02:05 INFO - blobuploader == 1.2.4 04:02:05 INFO - docopt == 0.6.1 04:02:05 INFO - functools32 == 3.2.3-2 04:02:05 INFO - jsonschema == 2.5.1 04:02:05 INFO - manifestparser == 1.1 04:02:05 INFO - mozInstall == 1.13 04:02:05 INFO - mozcrash == 1.0 04:02:05 INFO - mozdebug == 0.1 04:02:05 INFO - mozdevice == 0.51 04:02:05 INFO - mozfile == 1.2 04:02:05 INFO - mozhttpd == 0.7 04:02:05 INFO - mozinfo == 0.10 04:02:05 INFO - mozleak == 0.1 04:02:05 INFO - mozlog == 3.5 04:02:05 INFO - moznetwork == 0.27 04:02:05 INFO - mozprocess == 0.25 04:02:05 INFO - mozprofile == 0.28 04:02:05 INFO - mozrunner == 6.13 04:02:05 INFO - mozscreenshot == 0.1 04:02:05 INFO - mozsystemmonitor == 0.3 04:02:05 INFO - moztest == 0.8 04:02:05 INFO - mozversion == 1.4 04:02:05 INFO - psutil == 3.1.1 04:02:05 INFO - requests == 1.2.3 04:02:05 INFO - wsgiref == 0.1.2 04:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02: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')]} 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:02:05 INFO - Using env: {'DISPLAY': ':0', 04:02:05 INFO - 'HOME': '/home/cltbld', 04:02:05 INFO - 'LANG': 'en_US.UTF-8', 04:02:05 INFO - 'LANGUAGE': 'en_US:en', 04:02:05 INFO - 'LOGNAME': 'cltbld', 04:02:05 INFO - 'MAIL': '/var/mail/cltbld', 04:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:05 INFO - 'MOZ_NO_REMOTE': '1', 04:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:05 INFO - 'NO_EM_RESTART': '1', 04:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:05 INFO - 'PWD': '/builds/slave/test', 04:02:05 INFO - 'SHELL': '/bin/bash', 04:02:05 INFO - 'SHLVL': '1', 04:02:05 INFO - 'TERM': 'linux', 04:02:05 INFO - 'TMOUT': '86400', 04:02:05 INFO - 'USER': 'cltbld', 04:02:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:05 INFO - '_': '/tools/buildbot/bin/python'} 04:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:02:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:07 INFO - Installing collected packages: simplejson 04:02:07 INFO - Running setup.py install for simplejson 04:02:07 INFO - building 'simplejson._speedups' extension 04:02:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:02:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:02:08 INFO - Successfully installed simplejson 04:02:08 INFO - Cleaning up... 04:02:08 INFO - Return code: 0 04:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:08 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, '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': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:02:08 INFO - Using env: {'DISPLAY': ':0', 04:02:08 INFO - 'HOME': '/home/cltbld', 04:02:08 INFO - 'LANG': 'en_US.UTF-8', 04:02:08 INFO - 'LANGUAGE': 'en_US:en', 04:02:08 INFO - 'LOGNAME': 'cltbld', 04:02:08 INFO - 'MAIL': '/var/mail/cltbld', 04:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:08 INFO - 'MOZ_NO_REMOTE': '1', 04:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:08 INFO - 'NO_EM_RESTART': '1', 04:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:08 INFO - 'PWD': '/builds/slave/test', 04:02:08 INFO - 'SHELL': '/bin/bash', 04:02:08 INFO - 'SHLVL': '1', 04:02:08 INFO - 'TERM': 'linux', 04:02:08 INFO - 'TMOUT': '86400', 04:02:08 INFO - 'USER': 'cltbld', 04:02:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:08 INFO - '_': '/tools/buildbot/bin/python'} 04:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:08 INFO - Cleaning up... 04:02:08 INFO - Return code: 0 04:02:08 INFO - Running post-action listener: _resource_record_post_action 04:02:08 INFO - Running post-action listener: _start_resource_monitoring 04:02:08 INFO - Starting resource monitoring. 04:02:08 INFO - [mozharness: 2017-09-09 11:02:08.481728Z] Finished create-virtualenv step (success) 04:02:08 INFO - [mozharness: 2017-09-09 11:02:08.482245Z] Running install step. 04:02:08 INFO - Running pre-action listener: _resource_record_pre_action 04:02:08 INFO - Running main action method: install 04:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:08 INFO - Reading from file tmpfile_stdout 04:02:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:08 INFO - Reading from file tmpfile_stdout 04:02:08 INFO - Output received: 04:02:08 INFO - Usage: mozinstall [options] installer 04:02:08 INFO - Options: 04:02:08 INFO - -h, --help show this help message and exit 04:02:08 INFO - -d DEST, --destination=DEST 04:02:08 INFO - Directory to install application into. [default: 04:02:08 INFO - "/builds/slave/test"] 04:02:08 INFO - --app=APP Application being installed. [default: firefox] 04:02:08 INFO - mkdir: /builds/slave/test/build/application 04:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:02:25 INFO - Reading from file tmpfile_stdout 04:02:25 INFO - Output received: 04:02:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:25 INFO - Running post-action listener: _resource_record_post_action 04:02:25 INFO - [mozharness: 2017-09-09 11:02:25.224486Z] Finished install step (success) 04:02:25 INFO - [mozharness: 2017-09-09 11:02:25.224736Z] Running setup-mitmproxy step. 04:02:25 INFO - Running pre-action listener: _resource_record_pre_action 04:02:25 INFO - Running main action method: setup_mitmproxy 04:02:25 INFO - Skipping: mitmproxy is not required 04:02:25 INFO - Running post-action listener: _resource_record_post_action 04:02:25 INFO - [mozharness: 2017-09-09 11:02:25.225857Z] Finished setup-mitmproxy step (success) 04:02:25 INFO - [mozharness: 2017-09-09 11:02:25.226075Z] Running run-tests step. 04:02:25 INFO - Running pre-action listener: _resource_record_pre_action 04:02:25 INFO - Running pre-action listener: _set_gcov_prefix 04:02:25 INFO - Running main action method: run_tests 04:02:25 WARNING - Try message not found. 04:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:25 INFO - Python 2.7.3 04:02:25 INFO - Return code: 0 04:02:25 INFO - grabbing minidump binary from tooltool 04:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:25 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 0x2bc0090>, '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 0x2bc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:02:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:02:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:25 INFO - Return code: 0 04:02:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:25 INFO - ENV: RUST_BACKTRACE is now full 04:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:02:25 INFO - Using env: {'DISPLAY': ':0', 04:02:25 INFO - 'HOME': '/home/cltbld', 04:02:25 INFO - 'LANG': 'en_US.UTF-8', 04:02:25 INFO - 'LANGUAGE': 'en_US:en', 04:02:25 INFO - 'LOGNAME': 'cltbld', 04:02:25 INFO - 'MAIL': '/var/mail/cltbld', 04:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:25 INFO - 'MOZ_NO_REMOTE': '1', 04:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:25 INFO - 'NO_EM_RESTART': '1', 04:02:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:25 INFO - 'PWD': '/builds/slave/test', 04:02:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:25 INFO - 'RUST_BACKTRACE': 'full', 04:02:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:25 INFO - 'SHELL': '/bin/bash', 04:02:25 INFO - 'SHLVL': '1', 04:02:25 INFO - 'TERM': 'linux', 04:02:25 INFO - 'TMOUT': '86400', 04:02:25 INFO - 'USER': 'cltbld', 04:02:25 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:25 INFO - '_': '/tools/buildbot/bin/python'} 04:02:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:02:25 INFO - mozversion application_buildid: 20170909094348 04:02:25 INFO - mozversion application_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 04:02:25 INFO - mozversion application_display_name: Nightly 04:02:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:25 INFO - mozversion application_name: Firefox 04:02:25 INFO - mozversion application_remotingname: firefox 04:02:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:02:25 INFO - mozversion application_vendor: Mozilla 04:02:25 INFO - mozversion application_version: 57.0a1 04:02:25 INFO - mozversion platform_buildid: 20170909094348 04:02:25 INFO - mozversion platform_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 04:02:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:02:25 INFO - mozversion platform_version: 57.0a1 04:02:25 INFO - using testdate: 1504954945 04:02:25 INFO - actual date: 1504954945 04:02:25 INFO - starting webserver on 'localhost:44027' 04:02:25 INFO - SUITE-START | Running 2 tests 04:02:25 INFO - TEST-START | dromaeo_css 04:02:25 INFO - Initialising browser for dromaeo_css test... 04:02:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44027/getInfo.html -profile /tmp/tmpsLfieX/profile 04:02:25 INFO - TEST-INFO | started process 2383 (/builds/slave/test/build/application/firefox/firefox http://localhost:44027/getInfo.html) 04:02:31 INFO - TEST-INFO | 2383: exit 0 04:02:31 INFO - Browser initialized. 04:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:31 INFO - Using env: {'DISPLAY': ':0', 04:02:31 INFO - 'HOME': '/home/cltbld', 04:02:31 INFO - 'JSGC_DISABLE_POISONING': '1', 04:02:31 INFO - 'LANG': 'en_US.UTF-8', 04:02:31 INFO - 'LANGUAGE': 'en_US:en', 04:02:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:02:31 INFO - 'LOGNAME': 'cltbld', 04:02:31 INFO - 'MAIL': '/var/mail/cltbld', 04:02:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:31 INFO - 'MOZ_CRASHREPORTER': '1', 04:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:02:31 INFO - 'MOZ_NO_REMOTE': '1', 04:02:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:31 INFO - 'NO_EM_RESTART': '1', 04:02:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:31 INFO - 'PWD': '/builds/slave/test', 04:02:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:31 INFO - 'RUST_BACKTRACE': 'full', 04:02:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:31 INFO - 'SHELL': '/bin/bash', 04:02:31 INFO - 'SHLVL': '1', 04:02:31 INFO - 'STYLO_FORCE_DISABLED': '1', 04:02:31 INFO - 'TERM': 'linux', 04:02:31 INFO - 'TMOUT': '86400', 04:02:31 INFO - 'USER': 'cltbld', 04:02:31 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:31 INFO - '_': '/tools/buildbot/bin/python'} 04:02:31 INFO - TEST-INFO | started process 2659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsLfieX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:32 INFO - PID 2659 | 04:02:32 INFO - PID 2659 | (/builds/slave/test/build/application/firefox/firefox:2714): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:02:32 INFO - PID 2659 | 04:02:42 INFO - PID 2659 | RSS: Main: 158138368 04:02:42 INFO - PID 2659 | 04:05:40 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44027/tests/dromaeo/cssquery-ext.html) 04:05:41 INFO - PID 2659 | RSS: Main: 165400576 04:05:41 INFO - PID 2659 | 04:08:42 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-ext.html (next: http://localhost:44027/tests/dromaeo/cssquery-jquery.html) 04:08:43 INFO - PID 2659 | RSS: Main: 161161216 04:08:43 INFO - PID 2659 | 04:11:45 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44027/tests/dromaeo/cssquery-mootools.html) 04:11:45 INFO - PID 2659 | RSS: Main: 164425728 04:11:45 INFO - PID 2659 | 04:14:47 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44027/tests/dromaeo/cssquery-prototype.html) 04:14:47 INFO - PID 2659 | RSS: Main: 162611200 04:14:47 INFO - PID 2659 | 04:17:50 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44027/tests/dromaeo/cssquery-yui.html) 04:17:51 INFO - PID 2659 | RSS: Main: 163934208 04:17:51 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | Cycle 1(1): loaded http://localhost:44027/tests/dromaeo/cssquery-yui.html (next: http://localhost:44027/tests/dromaeo/cssquery-dojo.html) 04:20:52 INFO - PID 2659 | RSS: Main: 164474880 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | __start_tp_report 04:20:52 INFO - PID 2659 | _x_x_mozilla_page_load 04:20:52 INFO - PID 2659 | _x_x_mozilla_page_load_details 04:20:52 INFO - PID 2659 | |i|pagename|runs| 04:20:52 INFO - PID 2659 | |0;dojo.html;3853.0367408147963;3870.342041852885;3872.3804191329386;3879;3892.0269932516862;6212.471939885115;6259.593126446778;6313.463355614773;6346;6347.587406818554;6342.841428964267;6346.048092786073;6350.714217860196;6354.745810167599;6385.201849768779;5577.386487486373;5645.802396916099;5661.971690141543;5693.373728889819;5792.884142317151;5714.942850571482;5719.828405147831;5743.081107022877;5765.106408506667;5782.132680097977;5551.139573366135;5721.8569535761735;5798.130280457923;5804.477597016267;5819.854503637422;5545.279113715191;5620.803271885506;5666.065099258659;5731.484166425042;5745.856353591152;5687.289088863892;5696.743646535916;5733.741981610796;5754.1944127822135;5781.913271300934;6219.253689557237;6303.212098487689;6314.494840412756;6331.398517140864;6412.070249813797;6825.419839313664;6927.099477067949;6956.339147780953;6960.895586566206;6970.546914450595;6902.068220790179;6913.481488888303;6921.238663746984;7000.789976300719;7011;6328.177336946167;6333;6355.586886852339;6372.745090196433;6372.840678983062;6897.827554311182;6908.827279317957;6951.200611929592;7049.048378468944;7054.047703559953;6746.595204287759;6746.595204287759;6761.425278851254;6801.795946121525;6829.078074459983;6743.5953842769595;6845;6852.725890964306;6922.376986071277;6953.860922781516;6705.731770729116;6766.28953959837;6775.966120169368;6847.657617119125;6854.074699915547;6671.899921501182;6832.6925288362145;6842.349976752201;6844.93155068443;6857.931420685829;4843.321934929113;4853.247746599282;4907.3620429343955;4917.459079501252;4943.456219815817;4418.226810308183;4471.955280447219;4482.081173359454;4506.121306345297;4546.1135078659345;6271.27880293763;6341.8097457076365;6345.682715864281;6350.364963503705;6362.872742545123;6739.123913891261;6739.797806065826;6823.488238382141;6831.795046148623;6861;6235.220597425322;6260.280067792262;6321.0834429008455;6346.11154438379;6398.168238129107;5479.863003424946;5532.5297349724915;5539.030669632879;5555.8888822224135;5556.638818476786;7131.251218622074;7140.285971402818;7221.205667376585;7223.927760722326;7225.5664660120565;6670.633115178712;6749.223839258351;6754.324567543206;6832.385085342343;6905.689243983932;7096.325849044332;7193.244709305448;7194.964025179841;7209.567425954249;7210.531315464478;6751.324867513209;6756.493263005196;6761.391474767098;6843.178818541807;6845.726170953106;6749.932500675127;6795.150606174228;6842.178938527409;6872.41584465326;6876.587404755731;6625.933740662532;6686.498512611476;6688.665566721547;6700.195976482853;6701.32986701326;6474.223093228654;6546.672666366758;6624.238212605419;6626.734930602722;6659.20089589233;6503.219613646393;6511.38141876521;6530.346965303432;6585.769498067544;6605.504587155887;6626.56927299724;6680.565763225375;6720;6751.696173672295;6763.053172555748;6428.550001500037;6437.420632143129;6452.838679033061;6529.608223506415;6532.510061745293 04:20:52 INFO - PID 2659 | |1;ext.html;923.6905636611734;942.8067246214526;963.6049219819873;995.1839491616872;998.0767789794438;42907;43490.56509434913;43524.56475435245;44208.11583768327;44353.33469997949;40104;40474;40556.59443405565;40569.391459128135;40900.79549602248;7025.648717564114;7079.929200708004;7126.786196414116;7157.284271572853;7163.64181790911;7366.5948372839475;7521.699132034712;7529.47293689442;7537.736179233728;7542.3211910928;7487.475876688634;7539;8030;8185.7135000275;8200.26197642212;8099.230573095547;8168.714095006646;8172.754817355489;8181.550014749187;8199.877001844918;7918;8020.879686804644;8101.635426405767;8107.635156417975;8130;41309.380359294635;41742.37386439206;41746.79126604378;41756.58243417557;41818.79090604558;3711.480392745018;3775.5091838061153;3779.7165212609166;3779.7354185207046;3781.4138808484727;33994.6600533994;34063.14842128967;34076.14809629754;34085.48871766926;34130.82934585336;5479.123340265538;5487.807926722546;5517.779288828442;5524.895020995817;5539.030669632798;221045;222704;222798;222974;224434;51912.48087519076;52105;52268;52402.737986309825;52574.47425525696;54404.72797635986;54426.18360724593;54568.72715636476;54575;54725;16318.265678044516;16505.917470412573;16513;16514.42199523011;16535;13330.933345333211;13364.532241371506;13369.131006484547;13373;13384.130031547918;14624.195669238294;14851.70296594062;14916.776248356284;14977.475788347356;15003.549893503212;5781.364049954502;5948.791792287249;5980.43185897339;5980.790672326448;6023.608465449732;1089.2593036735095;1091.5851976248975;1103.2442776697987;1105.4141305108305;1105.8341248812742;25893.352666183495;25908.87045564798;26145.477090458084;26275;26377.340566485607;1194.0209028596641;1201.891829735328;1223.3883058470765;1228.7173949991552;1237.1587320622064;13669.179849209078;13709.931450342685;13875.028747987544;13961.720765584834;13996.72006559863;289616;291391;291902;291964;292604;57445.71277143671;58884;61871;62344;62584;1498.932548035341;1524.6112241378378;1537.22370203049;1547.0485651324354;1549.7907782449452;30211.546826797177;30332.696673032988;30865.537016944316;31017;31161.220969475038;38264.426033608965;38352.80823595864;38385.23229535449;38468.61531384762;38501.61498385092;233123;236474;236646;237484;237559;34536.65463345334;35426.291474169855;35718;35777.64222357743;35954.64045359618;45630.31554526618;45837.31244031276;46199.53800461952;46615.30077048915;46746.53253467422;33695.494567581016;34059.65940340565;34282.65717342895;34546.48180277348;34855;34195.316093678484;34486;34752.65247347494;34914.30171396609;35303.11742206466;40258.396124058745;40300.1939961205;40411.59588404196;40714.79642601887;40851.18297633971;33778.831105844314;33849.49225761665;33856.15359615931;33970.320593587494;34523.13692157716;24942.376440588403;25579.48841023132;25902.35244118912;26008.479830403663;26280.21159365222 04:20:52 INFO - PID 2659 | |2;jquery.html;590.3742033444546;593.6230493636541;600.6366148480166;610.3835126522214;619.1177571959958;22852.54294914103;23710.52578948422;23714.407139821513;23775;23779.405514862137;25256.242312730603;26854.194374168757;27497.725022749768;27577.172684819438;27657.170284891436;6711.19465664121;6834.487413443987;6846.760363387282;6873.931260687379;6875.828104297382;6661.766838160665;6783.6269005204695;6880.965595172017;6904.791661459224;6949.166100067999;6872.244053154149;6873.037774711544;6877.690503927335;6878.7248510059535;6888.001239820223;6591.5056370772145;6836.213835408942;6836.897446538306;6847.246802851682;6867.656617169147;6385.042243663441;6391;6402.263739669951;6407.295197528269;6414.198225221848;30379.392412151632;30846.53730194049;30913.845430772926;30918.845405773052;30928.8453557733;2178.7385513738295;2193.4954960359046;2216.9224077157223;2218.944526386837;2222.9888850555644;20106.597868042558;20711.689324660143;20857.68713469299;20870.686939695915;20936.057877395553;2476.938076548083;2497.500499900027;2550.655661485694;2588.896444142232;2610.464854704781;136363;141654;142740.28629856888;154024;160234;16068.598285042734;16614.916925415295;16669.91665041691;16743.497695069167;16781.160941952854;26386.86806565955;26433;26460.0738974135;26481.33796655099;26501.072462463722;10837;10862.891371086345;10901.890981090246;10940.398278094623;11018.614348497764;9817.852732209023;9823.656172033945;9875.654352097643;9885.555150018266;9978.351407158512;10017.39895606266;10213.438260895722;10357.689269321932;10371.533281002223;10377.481125943672;2909.170886297395;2909.185428080141;2921.45043771814;2952.896648617288;3030.757539396843;1015.9746006349752;1039.9220058495644;1044.770150566874;1047.3925123428546;1065.211743309945;21513.78486215149;21557.78442215589;21763.564728705653;21899.124035038738;22447;1086.380762965118;1089.2375337263948;1100.7578332766939;1107.2470719910539;1123.640435060789;11955.820662690066;12174.878251217551;12198.02415806751;12207.572734954234;12248.142630015813;578664;606840;614819;617766;624332;129458;133461.33269333592;133525;133818.99049129165;134601;1117.5920788911988;1162.9011534019703;1203.4825025239056;1229.8893099620898;1264.50684233151;23701.407464812826;23727.762722372554;23916.40208994789;24091.63862542028;24176.63735044011;62837.37162628315;63734.36265637284;63886;64778.35221647723;66386;81283.18716812757;83792;83900.16099838924;83962;85519.5724021376;15927.920360398588;15993;16072.437464688679;16166.272517736496;16168.949018313771;22418.215362462237;25295.36761580975;25789;25814.612780807925;25897.352566185997;17211.56971075683;17256.913715431343;17290;20075.79924200798;20530.897345513178;17893.463196104138;18275.36036238725;18307.908460458144;18467.984260865782;18778.718319225496;20945.790542094383;21132.894335528224;21243.46891327729;21270.36188914335;21566.460838479165;16004.199790010685;16065;16090.839091608934;16099.75850362269;16366.509004729876;20280.391588252376;20442;20499.69250461274;20537.589248215252;20549.89725051365 04:20:52 INFO - PID 2659 | |3;mootools.html;1367.4120128344812;1447.6308541321962;1471.9043262187963;1488.8362280149188;1493.223523767641;16503.587410314747;17116.828831711693;17147.14264286784;17154.056526891018;17165;16643.750343744825;16685.582860428465;16691.49925502237;16691.749623755655;16762.32950681971;2739.917802465919;2746.231055304518;2783.582462630601;2786.9442611147765;2787.7212278772163;2696.9460610787773;2738.7672047875953;2741;2747.615333853262;2749.3539018330675;2704.377993061597;2713.986430067847;2720.3471166919994;2825;2836.6170566973506;2717.565189569669;2735.261479400551;2736.5621500559814;2740.8081434299606;2742.424090940895;2632.723564025769;2663.973360266392;2703.526882795503;2707.458508298348;2708.647875776156;16540.255688493926;16713.247903844356;16714.16429178536;16719.749203761952;16726.66546669072;8143.877841832377;8381.161883811632;8395.28640065589;8397.370197235232;8402.705905293285;5361.169018802092;5545.889082218373;5589.133684278943;5602.187682785973;5616.073347897592;2133.25336132354;2154.504463973279;2160.092761040367;2204.790544898232;2211.5355775287208;30486.390272194654;30765.077047688606;30791.84604076965;30811.45942702856;30858;6754.93245067543;6889.414399775975;6924.099867017357;7054.2240353561065;7063.117110361205;19431.902840485705;19710.60578788416;19717.112729927187;19728.70406943897;19735.703964440545;8148.470349427268;8416.957915210507;8419.200175983271;8426.915730842737;8431.536265505334;7661.770146895602;7716.459847810599;7763.223677632304;7791.649375778104;7796.142424333319;5451.972740136274;5559.305086864142;5671.177679236487;5700.8004719835435;5702.230198923092;1554.1840533719887;1590.1810567557718;1590.6103004763675;1593.1158207194887;1593.8326475720114;927.679950417105;950.2445555783031;959.0936564946059;965.888922773876;972.7373609125497;9051.094890510896;9209.631614735335;9254.213391861633;9298.256139508823;9453.385529940531;770.7302444144505;778.696308439709;785.9135495095535;792.1919641965163;801.1587832775679;5041.2438134280155;5313.681179129265;5822.563307751935;5833.67914764692;6016.458518733335;24297;24498;24840;25340.366490837878;25381.746182538307;24701.38246543815;25066.498670026496;25261.62107568388;25283.873580632346;25333.240002799947;11907.345096019802;12115.575954841539;12146.089043321786;12215.633530993906;12298.692532686755;8786.692465763668;9214.124658157465;9283.164515193665;9355;9383.061693830836;20874.582508350053;21039.263625773023;21142.260020899193;21411.35765927025;21761;21731.674024889322;22079.889600551895;22092.11631534785;22144.2249521266;22211.22260720867;12135.393230338272;12332.260064396165;12334.50661973511;12393.62819115428;12402.25586464815;15307.846921530641;15400.614984625026;15417.922910385376;15473.148976806384;15473.922630386776;12109.939450302692;12482.812757808459;12498.312592807482;12548.686282843002;12614.432350544432;12084.939575302067;12251.203671761306;12376.381180940736;12554;12594.433250503933;10647;10982.835257470984;10986.505607247853;10987.285826421257;11016.228863979444;7882.251186137308;7902.920970790448;7928.207179282025;8040.5979701015885;8139.959300203698;8132.430729848854;8158.796030099295;8163.918360816316;8172.7956801080445;8219.054808697076 04:20:52 INFO - PID 2659 | |4;prototype.html;526.6892533405293;562.5246666566751;562.7073921560791;567.2540609099035;573.8393249890032;6199;6199.132121502993;6218.37816218378;6278.497720182386;6368.363163683635;6154.846128846781;6216.222972128484;6256.468200202989;6261.436470717635;6265.906011409821;5081.59347252219;5099.184130539114;5118.59051275897;5122;5145.3568303962;4997.425296090942;5038.420581633122;5155.633757054384;5156.793728250866;5157.123289040854;4799.0725657348985;4871.756412179395;5086.593072554187;5101.362329708786;5113.744312784364;4956.9428687095;4957.603391728653;4971.45314015458;4984.252362145689;4989.600831933437;4428.557144285545;4451.888702782424;4466.196084704752;4498.482674492409;4511.939694171867;6018.96990515049;6031.577789554733;6084.26988761347;6108.236470441195;6119.694015299217;5793.7972170974235;5875.794347197871;5875.882482350372;5901.911471327933;5910.763569457216;6432.131662225634;6559.6064236145985;6567.277599464055;6589.538732288742;6615;4979.950200497985;4988.90022199554;5007.84976450707;5048.939722658246;5057.974710126426;6675.299093595199;6760.594364338155;6788.253292137911;6892.517523773338;6918.688659010306;5156.819511317086;5189.247559103985;5189.584833213334;5213.296205012275;5214.817481388209;5213.582913366921;5213.843584692389;5238.214267859851;5311.867203319948;5312.73436328182;5790.710464476843;5804.245448091721;5834.212381328552;5839.299284085937;5892.558058145656;6609.570377925419;6610.950605312369;6622.63575503352;6658.9001164982565;6670;1781.1361489677497;1817.7727784026997;1827.3238901606226;1835.752173456593;1846.4922146409576;1244.9688757780946;1273.19152338264;1286.5462027908404;1312.8162057311984;1321.3129172830268;6180.381961803783;6191.318954914956;6221.160143380585;6236.345183755731;6253.812385628438;6518.598501322239;6544.672766361663;6637;6653.733850646016;6712.42944349726;6054.788082417094;6100.450959413674;6101.664408457577;6177.567570270038;6205.193324867739;3494.9301013980084;3505.914794980452;3511.1741894215374;3528.6118526962014;3543.344481270973;6877.386593094692;6899.93100069003;7017.614031228331;7025.508214424941;7056.5775598834525;6892.4836535962;6912.308769123148;6917.51577389588;6924.757633482804;7002.529468811505;6959.930400696029;6969.407600353925;7004.824879378057;7018.999999999898;7040.6479676016;6642;6678.532502724763;6680.866382672222;6748.325167483213;6811.795646130624;6618.338166183343;6695.564788288746;6706.66466676674;6715.496337774589;6720.6975686093265;6987.790366289019;7035.401990830836;7055.118110236221;7056.964715176391;7085.539439936388;5177.119889618699;5208.401033881152;5222.582193424441;5226.63413561047;5229.954009198252;6518.120053792677;6597.241317248578;6667.899981500184;6695.397414232742;6762.594244345355;6472.546921715623;6529.771457998947;6576.572522786004;6583.572067815769;6595.967020164869;6456.644884531396;6520.608763474207;6523.24982627004;6537.607743535403;6596.208454985433;6344.333844946214;6397.680115994275;6412.903806442814;6490.902636460362;6500.577462464925;6520.18497687789;6540.705668244846;6625.933740662532;6682.766103186365;6716.126903502513;6401.93598064032;6425.453836423956;6462.838429039311;6480.967595161994;6520.902186467112 04:20:52 INFO - PID 2659 | |5;yui.html;985.4136788610774;988.7111337254256;1004.0662184168725;1016.5273147986187;1021.0657248617506;20403.387898363053;21081.683774743393;21175.894120529396;21188;21193.152273909065;19040.238390464365;19314.903425482888;19316.90341548294;19325.613487730236;19328.90335548324;1025.4206373399043;1050.0916707048386;1050.4117694091294;1050.5220124843179;1050.768830857214;974.6198982396871;978.5107446276861;978.7699890525721;982.4449186209769;983.6655537117379;1012.7492546704814;1134.625573560723;1135.7160709822545;1140.680609429357;1140.954361825526;1127.780082883838;1129.3788416371003;1130.559081958037;1132.4620805117586;1133.1501373969522;779.2597032818845;799.7960520067346;803.7829785957758;804.0833449867156;804.2801692485251;19311.227550897947;19361.9031904841;19414.22343106274;19419.417417477358;19485.707714384294;21506.462338441506;21641;21696.457588560414;21981.780182198294;22012.119515219372;17680.469585912444;17714.91142544279;17829.643407131785;17959.56323494117;18052.54868628282;3854.3447613905705;3859.4982652255308;3874.8256328465286;3874.9612503874882;3885.2229554089013;131225;163074;164343.17828410902;166365;168582.99999999878;16389.262483188286;17411.56471088233;17644.823551764573;17679.469615911545;17774.377896773552;27192;27402;27533.724662753117;27583;27625.72374276272;9453.952730236304;9477.336586439022;9529;9571.61713531451;9583.281253905985;4433.933490997638;4529.6376289896725;4547.909041819145;4550.863474095782;4551.931721024187;5909.940900591025;6007.369226231182;6067.7269522871575;6067.969660151759;6094.390560943959;1170.8126699728002;1203.284045992633;1219.945102470391;1223.577865636354;1224.6815827884636;738.151126204858;744.6835095084567;752.5409500204871;770.9691612335444;772.0118248641747;13332.93333533326;13846.653833654038;14131.434742610387;14504.782428263585;14541.854581454261;737.181728281607;744.3301029073768;747.9065116860393;763.4426868386109;764.399946042354;6296.464800492009;6309.558330916791;6354.809355719336;6421.486281097501;6426.518011149183;144316;144959.2752036254;146142.269288655;147393;147476;128105.35947320204;128520;130330.34834825955;132514;136660;114413;114621;114775.85224147819;115947.42026289983;119063;11976.940115299367;11980.640580782241;12044.21712588679;12065.51737930508;12070.939645301718;56232.43767562436;56729.71635141798;56990.43009569851;57228;58087.419125809894;72587;72659.27340726525;73938.63030685027;76188.61905690435;77198;17506.474805755846;17935.461936141935;17943.371981980566;18018.639627207645;18067.638647227246;16254.918725406298;16540.586485337964;16646.75029874577;16679.49961501157;16741.581460463585;17230.913845430692;17351.56621084483;17519.649607008043;17520.474385768448;17650.470485885446;16609.584760381087;16733.581660458098;16832.326706931584;16988.235529401452;17073.231704573573;17027.7445838315;17294.13529323554;17301.740473893155;17345.739813903056;17368.565785855455;11092.22354435214;11174.27367221128;11232.606858759904;11311.377874216998;11351.14866385008;12234.938825305817;12273.140880138304;12453.688657783629;12543.686407839512;12686.873131268938 04:20:52 INFO - PID 2659 | __end_tp_report 04:20:52 INFO - PID 2659 | __start_cc_report 04:20:52 INFO - PID 2659 | _x_x_mozilla_cycle_collect,342 04:20:52 INFO - PID 2659 | __end_cc_report 04:20:52 INFO - PID 2659 | __startTimestamp1504956052964__endTimestamp 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | ------- Summary: start ------- 04:20:52 INFO - PID 2659 | Number of tests: 6 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#0] dojo.html Cycles:165 Average:6301.84 Median:6530.35 stddev:760.31 (11.6%) stddev-sans-first:737.97 04:20:52 INFO - PID 2659 | Values: 3853.0 3870.3 3872.4 3879.0 3892.0 6212.5 6259.6 6313.5 6346.0 6347.6 6342.8 6346.0 6350.7 6354.7 6385.2 5577.4 5645.8 5662.0 5693.4 5792.9 5714.9 5719.8 5743.1 5765.1 5782.1 5551.1 5721.9 5798.1 5804.5 5819.9 5545.3 5620.8 5666.1 5731.5 5745.9 5687.3 5696.7 5733.7 5754.2 5781.9 6219.3 6303.2 6314.5 6331.4 6412.1 6825.4 6927.1 6956.3 6960.9 6970.5 6902.1 6913.5 6921.2 7000.8 7011.0 6328.2 6333.0 6355.6 6372.7 6372.8 6897.8 6908.8 6951.2 7049.0 7054.0 6746.6 6746.6 6761.4 6801.8 6829.1 6743.6 6845.0 6852.7 6922.4 6953.9 6705.7 6766.3 6776.0 6847.7 6854.1 6671.9 6832.7 6842.3 6844.9 6857.9 4843.3 4853.2 4907.4 4917.5 4943.5 4418.2 4472.0 4482.1 4506.1 4546.1 6271.3 6341.8 6345.7 6350.4 6362.9 6739.1 6739.8 6823.5 6831.8 6861.0 6235.2 6260.3 6321.1 6346.1 6398.2 5479.9 5532.5 5539.0 5555.9 5556.6 7131.3 7140.3 7221.2 7223.9 7225.6 6670.6 6749.2 6754.3 6832.4 6905.7 7096.3 7193.2 7195.0 7209.6 7210.5 6751.3 6756.5 6761.4 6843.2 6845.7 6749.9 6795.2 6842.2 6872.4 6876.6 6625.9 6686.5 6688.7 6700.2 6701.3 6474.2 6546.7 6624.2 6626.7 6659.2 6503.2 6511.4 6530.3 6585.8 6605.5 6626.6 6680.6 6720.0 6751.7 6763.1 6428.6 6437.4 6452.8 6529.6 6532.5 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#1] ext.html Cycles:180 Average:42817.13 Median:3743.49 stddev:65554.91 (1751.2%) stddev-sans-first:65663.34 04:20:52 INFO - PID 2659 | Values: 923.7 942.8 963.6 995.2 998.1 42907.0 43490.6 43524.6 44208.1 44353.3 40104.0 40474.0 40556.6 40569.4 40900.8 7025.6 7079.9 7126.8 7157.3 7163.6 7366.6 7521.7 7529.5 7537.7 7542.3 7487.5 7539.0 8030.0 8185.7 8200.3 8099.2 8168.7 8172.8 8181.6 8199.9 7918.0 8020.9 8101.6 8107.6 8130.0 41309.4 41742.4 41746.8 41756.6 41818.8 3711.5 3775.5 3779.7 3779.7 3781.4 33994.7 34063.1 34076.1 34085.5 34130.8 5479.1 5487.8 5517.8 5524.9 5539.0 221045.0 222704.0 222798.0 222974.0 224434.0 51912.5 52105.0 52268.0 52402.7 52574.5 54404.7 54426.2 54568.7 54575.0 54725.0 16318.3 16505.9 16513.0 16514.4 16535.0 13330.9 13364.5 13369.1 13373.0 13384.1 14624.2 14851.7 14916.8 14977.5 15003.5 5781.4 5948.8 5980.4 5980.8 6023.6 1089.3 1091.6 1103.2 1105.4 1105.8 25893.4 25908.9 26145.5 26275.0 26377.3 1194.0 1201.9 1223.4 1228.7 1237.2 13669.2 13709.9 13875.0 13961.7 13996.7 289616.0 291391.0 291902.0 291964.0 292604.0 57445.7 58884.0 61871.0 62344.0 62584.0 1498.9 1524.6 1537.2 1547.0 1549.8 30211.5 30332.7 30865.5 31017.0 31161.2 38264.4 38352.8 38385.2 38468.6 38501.6 233123.0 236474.0 236646.0 237484.0 237559.0 34536.7 35426.3 35718.0 35777.6 35954.6 45630.3 45837.3 46199.5 46615.3 46746.5 33695.5 34059.7 34282.7 34546.5 34855.0 34195.3 34486.0 34752.7 34914.3 35303.1 40258.4 40300.2 40411.6 40714.8 40851.2 33778.8 33849.5 33856.2 33970.3 34523.1 24942.4 25579.5 25902.4 26008.5 26280.2 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#2] jquery.html Cycles:180 Average:40322.97 Median:22649.77 stddev:101743.59 (449.2%) stddev-sans-first:101985.27 04:20:52 INFO - PID 2659 | Values: 590.4 593.6 600.6 610.4 619.1 22852.5 23710.5 23714.4 23775.0 23779.4 25256.2 26854.2 27497.7 27577.2 27657.2 6711.2 6834.5 6846.8 6873.9 6875.8 6661.8 6783.6 6881.0 6904.8 6949.2 6872.2 6873.0 6877.7 6878.7 6888.0 6591.5 6836.2 6836.9 6847.2 6867.7 6385.0 6391.0 6402.3 6407.3 6414.2 30379.4 30846.5 30913.8 30918.8 30928.8 2178.7 2193.5 2216.9 2218.9 2223.0 20106.6 20711.7 20857.7 20870.7 20936.1 2476.9 2497.5 2550.7 2588.9 2610.5 136363.0 141654.0 142740.3 154024.0 160234.0 16068.6 16614.9 16669.9 16743.5 16781.2 26386.9 26433.0 26460.1 26481.3 26501.1 10837.0 10862.9 10901.9 10940.4 11018.6 9817.9 9823.7 9875.7 9885.6 9978.4 10017.4 10213.4 10357.7 10371.5 10377.5 2909.2 2909.2 2921.5 2952.9 3030.8 1016.0 1039.9 1044.8 1047.4 1065.2 21513.8 21557.8 21763.6 21899.1 22447.0 1086.4 1089.2 1100.8 1107.2 1123.6 11955.8 12174.9 12198.0 12207.6 12248.1 578664.0 606840.0 614819.0 617766.0 624332.0 129458.0 133461.3 133525.0 133819.0 134601.0 1117.6 1162.9 1203.5 1229.9 1264.5 23701.4 23727.8 23916.4 24091.6 24176.6 62837.4 63734.4 63886.0 64778.4 66386.0 81283.2 83792.0 83900.2 83962.0 85519.6 15927.9 15993.0 16072.4 16166.3 16168.9 22418.2 25295.4 25789.0 25814.6 25897.4 17211.6 17256.9 17290.0 20075.8 20530.9 17893.5 18275.4 18307.9 18468.0 18778.7 20945.8 21132.9 21243.5 21270.4 21566.5 16004.2 16065.0 16090.8 16099.8 16366.5 20280.4 20442.0 20499.7 20537.6 20549.9 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#3] mootools.html Cycles:180 Average:10364.42 Median:2708.05 stddev:7757.71 (286.5%) stddev-sans-first:7750.02 04:20:52 INFO - PID 2659 | Values: 1367.4 1447.6 1471.9 1488.8 1493.2 16503.6 17116.8 17147.1 17154.1 17165.0 16643.8 16685.6 16691.5 16691.7 16762.3 2739.9 2746.2 2783.6 2786.9 2787.7 2696.9 2738.8 2741.0 2747.6 2749.4 2704.4 2714.0 2720.3 2825.0 2836.6 2717.6 2735.3 2736.6 2740.8 2742.4 2632.7 2664.0 2703.5 2707.5 2708.6 16540.3 16713.2 16714.2 16719.7 16726.7 8143.9 8381.2 8395.3 8397.4 8402.7 5361.2 5545.9 5589.1 5602.2 5616.1 2133.3 2154.5 2160.1 2204.8 2211.5 30486.4 30765.1 30791.8 30811.5 30858.0 6754.9 6889.4 6924.1 7054.2 7063.1 19431.9 19710.6 19717.1 19728.7 19735.7 8148.5 8417.0 8419.2 8426.9 8431.5 7661.8 7716.5 7763.2 7791.6 7796.1 5452.0 5559.3 5671.2 5700.8 5702.2 1554.2 1590.2 1590.6 1593.1 1593.8 927.7 950.2 959.1 965.9 972.7 9051.1 9209.6 9254.2 9298.3 9453.4 770.7 778.7 785.9 792.2 801.2 5041.2 5313.7 5822.6 5833.7 6016.5 24297.0 24498.0 24840.0 25340.4 25381.7 24701.4 25066.5 25261.6 25283.9 25333.2 11907.3 12115.6 12146.1 12215.6 12298.7 8786.7 9214.1 9283.2 9355.0 9383.1 20874.6 21039.3 21142.3 21411.4 21761.0 21731.7 22079.9 22092.1 22144.2 22211.2 12135.4 12332.3 12334.5 12393.6 12402.3 15307.8 15400.6 15417.9 15473.1 15473.9 12109.9 12482.8 12498.3 12548.7 12614.4 12084.9 12251.2 12376.4 12554.0 12594.4 10647.0 10982.8 10986.5 10987.3 11016.2 7882.3 7902.9 7928.2 8040.6 8140.0 8132.4 8158.8 8163.9 8172.8 8219.1 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#4] prototype.html Cycles:180 Average:5619.81 Median:6217.30 stddev:1565.62 (25.2%) stddev-sans-first:1522.63 04:20:52 INFO - PID 2659 | Values: 526.7 562.5 562.7 567.3 573.8 6199.0 6199.1 6218.4 6278.5 6368.4 6154.8 6216.2 6256.5 6261.4 6265.9 5081.6 5099.2 5118.6 5122.0 5145.4 4997.4 5038.4 5155.6 5156.8 5157.1 4799.1 4871.8 5086.6 5101.4 5113.7 4956.9 4957.6 4971.5 4984.3 4989.6 4428.6 4451.9 4466.2 4498.5 4511.9 6019.0 6031.6 6084.3 6108.2 6119.7 5793.8 5875.8 5875.9 5901.9 5910.8 6432.1 6559.6 6567.3 6589.5 6615.0 4980.0 4988.9 5007.8 5048.9 5058.0 6675.3 6760.6 6788.3 6892.5 6918.7 5156.8 5189.2 5189.6 5213.3 5214.8 5213.6 5213.8 5238.2 5311.9 5312.7 5790.7 5804.2 5834.2 5839.3 5892.6 6609.6 6611.0 6622.6 6658.9 6670.0 1781.1 1817.8 1827.3 1835.8 1846.5 1245.0 1273.2 1286.5 1312.8 1321.3 6180.4 6191.3 6221.2 6236.3 6253.8 6518.6 6544.7 6637.0 6653.7 6712.4 6054.8 6100.5 6101.7 6177.6 6205.2 3494.9 3505.9 3511.2 3528.6 3543.3 6877.4 6899.9 7017.6 7025.5 7056.6 6892.5 6912.3 6917.5 6924.8 7002.5 6959.9 6969.4 7004.8 7019.0 7040.6 6642.0 6678.5 6680.9 6748.3 6811.8 6618.3 6695.6 6706.7 6715.5 6720.7 6987.8 7035.4 7055.1 7057.0 7085.5 5177.1 5208.4 5222.6 5226.6 5230.0 6518.1 6597.2 6667.9 6695.4 6762.6 6472.5 6529.8 6576.6 6583.6 6596.0 6456.6 6520.6 6523.2 6537.6 6596.2 6344.3 6397.7 6412.9 6490.9 6500.6 6520.2 6540.7 6625.9 6682.8 6716.1 6401.9 6425.5 6462.8 6481.0 6520.9 04:20:52 INFO - PID 2659 | 04:20:52 INFO - PID 2659 | [#5] yui.html Cycles:180 Average:27843.52 Median:17802.01 stddev:42152.26 (236.8%) stddev-sans-first:42222.27 04:20:52 INFO - PID 2659 | Values: 985.4 988.7 1004.1 1016.5 1021.1 20403.4 21081.7 21175.9 21188.0 21193.2 19040.2 19314.9 19316.9 19325.6 19328.9 1025.4 1050.1 1050.4 1050.5 1050.8 974.6 978.5 978.8 982.4 983.7 1012.7 1134.6 1135.7 1140.7 1141.0 1127.8 1129.4 1130.6 1132.5 1133.2 779.3 799.8 803.8 804.1 804.3 19311.2 19361.9 19414.2 19419.4 19485.7 21506.5 21641.0 21696.5 21981.8 22012.1 17680.5 17714.9 17829.6 17959.6 18052.5 3854.3 3859.5 3874.8 3875.0 3885.2 131225.0 163074.0 164343.2 166365.0 168583.0 16389.3 17411.6 17644.8 17679.5 17774.4 27192.0 27402.0 27533.7 27583.0 27625.7 9454.0 9477.3 9529.0 9571.6 9583.3 4433.9 4529.6 4547.9 4550.9 4551.9 5909.9 6007.4 6067.7 6068.0 6094.4 1170.8 1203.3 1219.9 1223.6 1224.7 738.2 744.7 752.5 771.0 772.0 13332.9 13846.7 14131.4 14504.8 14541.9 737.2 744.3 747.9 763.4 764.4 6296.5 6309.6 6354.8 6421.5 6426.5 144316.0 144959.3 146142.3 147393.0 147476.0 128105.4 128520.0 130330.3 132514.0 136660.0 114413.0 114621.0 114775.9 115947.4 119063.0 11976.9 11980.6 12044.2 12065.5 12070.9 56232.4 56729.7 56990.4 57228.0 58087.4 72587.0 72659.3 73938.6 76188.6 77198.0 17506.5 17935.5 17943.4 18018.6 18067.6 16254.9 16540.6 16646.8 16679.5 16741.6 17230.9 17351.6 17519.6 17520.5 17650.5 16609.6 16733.6 16832.3 16988.2 17073.2 17027.7 17294.1 17301.7 17345.7 17368.6 11092.2 11174.3 11232.6 11311.4 11351.1 12234.9 12273.1 12453.7 12543.7 12686.9 04:20:52 INFO - PID 2659 | -------- Summary: end -------- 04:20:52 INFO - PID 2659 | 04:20:53 INFO - TEST-INFO | 2659: exit 0 04:20:53 INFO - TEST-OK | dromaeo_css | took 1108031ms 04:20:53 INFO - TEST-START | kraken 04:20:53 INFO - Initialising browser for kraken test... 04:20:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44027/getInfo.html -profile /tmp/tmptbhwi6/profile 04:20:53 INFO - TEST-INFO | started process 3167 (/builds/slave/test/build/application/firefox/firefox http://localhost:44027/getInfo.html) 04:20:59 INFO - TEST-INFO | 3167: exit 0 04:20:59 INFO - Browser initialized. 04:20:59 INFO - Running cycle 1/1 for kraken test... 04:20:59 INFO - Using env: {'DISPLAY': ':0', 04:20:59 INFO - 'HOME': '/home/cltbld', 04:20:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:20:59 INFO - 'LANG': 'en_US.UTF-8', 04:20:59 INFO - 'LANGUAGE': 'en_US:en', 04:20:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:20:59 INFO - 'LOGNAME': 'cltbld', 04:20:59 INFO - 'MAIL': '/var/mail/cltbld', 04:20:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:20:59 INFO - 'MOZ_NO_REMOTE': '1', 04:20:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:59 INFO - 'NO_EM_RESTART': '1', 04:20:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:59 INFO - 'PWD': '/builds/slave/test', 04:20:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:59 INFO - 'RUST_BACKTRACE': 'full', 04:20:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:20:59 INFO - 'SHELL': '/bin/bash', 04:20:59 INFO - 'SHLVL': '1', 04:20:59 INFO - 'STYLO_FORCE_DISABLED': '1', 04:20:59 INFO - 'TERM': 'linux', 04:20:59 INFO - 'TMOUT': '86400', 04:20:59 INFO - 'USER': 'cltbld', 04:20:59 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1504954538.439132-353580130', 04:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:59 INFO - '_': '/tools/buildbot/bin/python'} 04:20:59 INFO - TEST-INFO | started process 3370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbhwi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:00 INFO - PID 3370 | 04:21:00 INFO - PID 3370 | (/builds/slave/test/build/application/firefox/firefox:3421): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:21:00 INFO - PID 3370 | 04:21:10 INFO - PID 3370 | RSS: Main: 157597696 04:21:10 INFO - PID 3370 | 04:21:13 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44027/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:13 INFO - PID 3370 | RSS: Main: 162611200 04:21:13 INFO - PID 3370 | 04:21:16 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44027/tests/kraken/driver.html?testName=audio-dft) 04:21:17 INFO - PID 3370 | RSS: Main: 163631104 04:21:17 INFO - PID 3370 | 04:21:20 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44027/tests/kraken/driver.html?testName=audio-fft) 04:21:20 INFO - PID 3370 | RSS: Main: 158879744 04:21:20 INFO - PID 3370 | 04:21:22 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44027/tests/kraken/driver.html?testName=audio-oscillator) 04:21:23 INFO - PID 3370 | RSS: Main: 160055296 04:21:23 INFO - PID 3370 | 04:21:25 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:25 INFO - PID 3370 | RSS: Main: 160231424 04:21:25 INFO - PID 3370 | 04:21:28 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44027/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:29 INFO - PID 3370 | RSS: Main: 160403456 04:21:29 INFO - PID 3370 | 04:21:33 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44027/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:33 INFO - PID 3370 | RSS: Main: 163352576 04:21:33 INFO - PID 3370 | 04:21:36 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44027/tests/kraken/driver.html?testName=json-parse-financial) 04:21:37 INFO - PID 3370 | RSS: Main: 163303424 04:21:37 INFO - PID 3370 | 04:21:38 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:39 INFO - PID 3370 | RSS: Main: 162758656 04:21:39 INFO - PID 3370 | 04:21:40 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:41 INFO - PID 3370 | RSS: Main: 162762752 04:21:41 INFO - PID 3370 | 04:21:43 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:44 INFO - PID 3370 | RSS: Main: 163168256 04:21:44 INFO - PID 3370 | 04:21:46 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:47 INFO - PID 3370 | RSS: Main: 162852864 04:21:47 INFO - PID 3370 | 04:21:49 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:50 INFO - PID 3370 | RSS: Main: 163233792 04:21:50 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | Cycle 1(1): loaded http://localhost:44027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44027/tests/kraken/driver.html?testName=ai-astar) 04:21:52 INFO - PID 3370 | RSS: Main: 165691392 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | __start_tp_report 04:21:52 INFO - PID 3370 | _x_x_mozilla_page_load 04:21:52 INFO - PID 3370 | _x_x_mozilla_page_load_details 04:21:52 INFO - PID 3370 | |i|pagename|runs| 04:21:52 INFO - PID 3370 | |0;ai-astar;109;117;106;105;106;108;106;109;105;108 04:21:52 INFO - PID 3370 | |1;audio-beat-detection;118;112;112;116;129;113;142;114;136;115 04:21:52 INFO - PID 3370 | |2;audio-dft;162;163;159;161;161;163;161;161;162;172 04:21:52 INFO - PID 3370 | |3;audio-fft;73;72;80;74;73;72;72;73;74;73 04:21:52 INFO - PID 3370 | |4;audio-oscillator;79;79;81;80;77;79;78;79;79;84 04:21:52 INFO - PID 3370 | |5;imaging-gaussian-blur;116;116;114;113;113;113;114;114;114;114 04:21:52 INFO - PID 3370 | |6;imaging-darkroom;150;149;155;149;150;150;152;151;150;152 04:21:52 INFO - PID 3370 | |7;imaging-desaturate;99;94;94;93;95;95;94;95;95;94 04:21:52 INFO - PID 3370 | |8;json-parse-financial;46;45;44;46;46;49;47;44;46;45 04:21:52 INFO - PID 3370 | |9;json-stringify-tinderbox;37;36;37;36;36;37;37;36;36;36 04:21:52 INFO - PID 3370 | |10;stanford-crypto-aes;73;71;73;73;72;71;71;70;75;73 04:21:52 INFO - PID 3370 | |11;stanford-crypto-ccm;113;110;116;114;117;109;108;116;107;113 04:21:52 INFO - PID 3370 | |12;stanford-crypto-pbkdf2;158;157;172;156;158;152;152;159;156;154 04:21:52 INFO - PID 3370 | |13;stanford-crypto-sha256-iterative;59;58;58;59;60;59;57;57;66;58 04:21:52 INFO - PID 3370 | __end_tp_report 04:21:52 INFO - PID 3370 | __start_cc_report 04:21:52 INFO - PID 3370 | _x_x_mozilla_cycle_collect,910 04:21:52 INFO - PID 3370 | __end_cc_report 04:21:52 INFO - PID 3370 | __startTimestamp1504956112517__endTimestamp 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | ------- Summary: start ------- 04:21:52 INFO - PID 3370 | Number of tests: 14 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:3.54 (3.3%) stddev-sans-first:3.73 04:21:52 INFO - PID 3370 | Values: 109.0 117.0 106.0 105.0 106.0 108.0 106.0 109.0 105.0 108.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:117.00 stddev:10.92 (9.3%) stddev-sans-first:11.54 04:21:52 INFO - PID 3370 | Values: 118.0 112.0 112.0 116.0 129.0 113.0 142.0 114.0 136.0 115.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:3.54 (2.2%) stddev-sans-first:3.75 04:21:52 INFO - PID 3370 | Values: 162.0 163.0 159.0 161.0 161.0 163.0 161.0 161.0 162.0 172.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.00 stddev:2.37 (3.2%) stddev-sans-first:2.50 04:21:52 INFO - PID 3370 | Values: 73.0 72.0 80.0 74.0 73.0 72.0 72.0 73.0 74.0 73.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:1.90 (2.4%) stddev-sans-first:2.01 04:21:52 INFO - PID 3370 | Values: 79.0 79.0 81.0 80.0 77.0 79.0 78.0 79.0 79.0 84.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 04:21:52 INFO - PID 3370 | Values: 116.0 116.0 114.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.81 (1.2%) stddev-sans-first:1.90 04:21:52 INFO - PID 3370 | Values: 150.0 149.0 155.0 149.0 150.0 150.0 152.0 151.0 150.0 152.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:0.71 04:21:52 INFO - PID 3370 | Values: 99.0 94.0 94.0 93.0 95.0 95.0 94.0 95.0 95.0 94.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:46.00 stddev:1.48 (3.2%) stddev-sans-first:1.56 04:21:52 INFO - PID 3370 | Values: 46.0 45.0 44.0 46.0 46.0 49.0 47.0 44.0 46.0 45.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#9] json-stringify-tinderbox Cycles:10 Average:36.40 Median:36.50 stddev:0.52 (1.4%) stddev-sans-first:0.50 04:21:52 INFO - PID 3370 | Values: 37.0 36.0 37.0 36.0 36.0 37.0 37.0 36.0 36.0 36.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:73.00 stddev:1.48 (2.0%) stddev-sans-first:1.54 04:21:52 INFO - PID 3370 | Values: 73.0 71.0 73.0 73.0 72.0 71.0 71.0 70.0 75.0 73.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:113.50 stddev:3.59 (3.2%) stddev-sans-first:3.80 04:21:52 INFO - PID 3370 | Values: 113.0 110.0 116.0 114.0 117.0 109.0 108.0 116.0 107.0 113.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.50 stddev:5.68 (3.6%) stddev-sans-first:6.02 04:21:52 INFO - PID 3370 | Values: 158.0 157.0 172.0 156.0 158.0 152.0 152.0 159.0 156.0 154.0 04:21:52 INFO - PID 3370 | 04:21:52 INFO - PID 3370 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.10 Median:59.00 stddev:2.60 (4.4%) stddev-sans-first:2.76 04:21:52 INFO - PID 3370 | Values: 59.0 58.0 58.0 59.0 60.0 59.0 57.0 57.0 66.0 58.0 04:21:52 INFO - PID 3370 | -------- Summary: end -------- 04:21:52 INFO - PID 3370 | 04:21:53 INFO - PID 3370 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:21:53 INFO - TEST-INFO | 3370: exit 0 04:21:53 INFO - TEST-OK | kraken | took 59743ms 04:21:53 INFO - SUITE-END | took 1167s 04:21:53 INFO - Completed test suite (00:19:28) 04:21:53 INFO - javascript benchmark 04:21:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9039.100299067562, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3853.0367408147963, 3870.342041852885, 3872.3804191329386, 3879.0, 3892.0269932516862, 6212.471939885115, 6259.593126446778, 6313.463355614773, 6346.0, 6347.587406818554, 6342.841428964267, 6346.048092786073, 6350.714217860196, 6354.745810167599, 6385.201849768779, 5577.386487486373, 5645.802396916099, 5661.971690141543, 5693.373728889819, 5792.884142317151, 5714.942850571482, 5719.828405147831, 5743.081107022877, 5765.106408506667, 5782.132680097977, 5551.139573366135, 5721.8569535761735, 5798.130280457923, 5804.477597016267, 5819.854503637422, 5545.279113715191, 5620.803271885506, 5666.065099258659, 5731.484166425042, 5745.856353591152, 5687.289088863892, 5696.743646535916, 5733.741981610796, 5754.1944127822135, 5781.913271300934, 6219.253689557237, 6303.212098487689, 6314.494840412756, 6331.398517140864, 6412.070249813797, 6825.419839313664, 6927.099477067949, 6956.339147780953, 6960.895586566206, 6970.546914450595, 6902.068220790179, 6913.481488888303, 6921.238663746984, 7000.789976300719, 7011.0, 6328.177336946167, 6333.0, 6355.586886852339, 6372.745090196433, 6372.840678983062, 6897.827554311182, 6908.827279317957, 6951.200611929592, 7049.048378468944, 7054.047703559953, 6746.595204287759, 6746.595204287759, 6761.425278851254, 6801.795946121525, 6829.078074459983, 6743.5953842769595, 6845.0, 6852.725890964306, 6922.376986071277, 6953.860922781516, 6705.731770729116, 6766.28953959837, 6775.966120169368, 6847.657617119125, 6854.074699915547, 6671.899921501182, 6832.6925288362145, 6842.349976752201, 6844.93155068443, 6857.931420685829, 4843.321934929113, 4853.247746599282, 4907.3620429343955, 4917.459079501252, 4943.456219815817, 4418.226810308183, 4471.955280447219, 4482.081173359454, 4506.121306345297, 4546.1135078659345, 6271.27880293763, 6341.8097457076365, 6345.682715864281, 6350.364963503705, 6362.872742545123, 6739.123913891261, 6739.797806065826, 6823.488238382141, 6831.795046148623, 6861.0, 6235.220597425322, 6260.280067792262, 6321.0834429008455, 6346.11154438379, 6398.168238129107, 5479.863003424946, 5532.5297349724915, 5539.030669632879, 5555.8888822224135, 5556.638818476786, 7131.251218622074, 7140.285971402818, 7221.205667376585, 7223.927760722326, 7225.5664660120565, 6670.633115178712, 6749.223839258351, 6754.324567543206, 6832.385085342343, 6905.689243983932, 7096.325849044332, 7193.244709305448, 7194.964025179841, 7209.567425954249, 7210.531315464478, 6751.324867513209, 6756.493263005196, 6761.391474767098, 6843.178818541807, 6845.726170953106, 6749.932500675127, 6795.150606174228, 6842.178938527409, 6872.41584465326, 6876.587404755731, 6625.933740662532, 6686.498512611476, 6688.665566721547, 6700.195976482853, 6701.32986701326, 6474.223093228654, 6546.672666366758, 6624.238212605419, 6626.734930602722, 6659.20089589233, 6503.219613646393, 6511.38141876521, 6530.346965303432, 6585.769498067544, 6605.504587155887, 6626.56927299724, 6680.565763225375, 6720.0, 6751.696173672295, 6763.053172555748, 6428.550001500037, 6437.420632143129, 6452.838679033061, 6529.608223506415, 6532.510061745293], "value": 6249.095564772681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.6905636611734, 942.8067246214526, 963.6049219819873, 995.1839491616872, 998.0767789794438, 42907.0, 43490.56509434913, 43524.56475435245, 44208.11583768327, 44353.33469997949, 40104.0, 40474.0, 40556.59443405565, 40569.391459128135, 40900.79549602248, 7025.648717564114, 7079.929200708004, 7126.786196414116, 7157.284271572853, 7163.64181790911, 7366.5948372839475, 7521.699132034712, 7529.47293689442, 7537.736179233728, 7542.3211910928, 7487.475876688634, 7539.0, 8030.0, 8185.7135000275, 8200.26197642212, 8099.230573095547, 8168.714095006646, 8172.754817355489, 8181.550014749187, 8199.877001844918, 7918.0, 8020.879686804644, 8101.635426405767, 8107.635156417975, 8130.0, 41309.380359294635, 41742.37386439206, 41746.79126604378, 41756.58243417557, 41818.79090604558, 3711.480392745018, 3775.5091838061153, 3779.7165212609166, 3779.7354185207046, 3781.4138808484727, 33994.6600533994, 34063.14842128967, 34076.14809629754, 34085.48871766926, 34130.82934585336, 5479.123340265538, 5487.807926722546, 5517.779288828442, 5524.895020995817, 5539.030669632798, 221045.0, 222704.0, 222798.0, 222974.0, 224434.0, 51912.48087519076, 52105.0, 52268.0, 52402.737986309825, 52574.47425525696, 54404.72797635986, 54426.18360724593, 54568.72715636476, 54575.0, 54725.0, 16318.265678044516, 16505.917470412573, 16513.0, 16514.42199523011, 16535.0, 13330.933345333211, 13364.532241371506, 13369.131006484547, 13373.0, 13384.130031547918, 14624.195669238294, 14851.70296594062, 14916.776248356284, 14977.475788347356, 15003.549893503212, 5781.364049954502, 5948.791792287249, 5980.43185897339, 5980.790672326448, 6023.608465449732, 1089.2593036735095, 1091.5851976248975, 1103.2442776697987, 1105.4141305108305, 1105.8341248812742, 25893.352666183495, 25908.87045564798, 26145.477090458084, 26275.0, 26377.340566485607, 1194.0209028596641, 1201.891829735328, 1223.3883058470765, 1228.7173949991552, 1237.1587320622064, 13669.179849209078, 13709.931450342685, 13875.028747987544, 13961.720765584834, 13996.72006559863, 289616.0, 291391.0, 291902.0, 291964.0, 292604.0, 57445.71277143671, 58884.0, 61871.0, 62344.0, 62584.0, 1498.932548035341, 1524.6112241378378, 1537.22370203049, 1547.0485651324354, 1549.7907782449452, 30211.546826797177, 30332.696673032988, 30865.537016944316, 31017.0, 31161.220969475038, 38264.426033608965, 38352.80823595864, 38385.23229535449, 38468.61531384762, 38501.61498385092, 233123.0, 236474.0, 236646.0, 237484.0, 237559.0, 34536.65463345334, 35426.291474169855, 35718.0, 35777.64222357743, 35954.64045359618, 45630.31554526618, 45837.31244031276, 46199.53800461952, 46615.30077048915, 46746.53253467422, 33695.494567581016, 34059.65940340565, 34282.65717342895, 34546.48180277348, 34855.0, 34195.316093678484, 34486.0, 34752.65247347494, 34914.30171396609, 35303.11742206466, 40258.396124058745, 40300.1939961205, 40411.59588404196, 40714.79642601887, 40851.18297633971, 33778.831105844314, 33849.49225761665, 33856.15359615931, 33970.320593587494, 34523.13692157716, 24942.376440588403, 25579.48841023132, 25902.35244118912, 26008.479830403663, 26280.21159365222], "value": 18525.049800095905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3742033444546, 593.6230493636541, 600.6366148480166, 610.3835126522214, 619.1177571959958, 22852.54294914103, 23710.52578948422, 23714.407139821513, 23775.0, 23779.405514862137, 25256.242312730603, 26854.194374168757, 27497.725022749768, 27577.172684819438, 27657.170284891436, 6711.19465664121, 6834.487413443987, 6846.760363387282, 6873.931260687379, 6875.828104297382, 6661.766838160665, 6783.6269005204695, 6880.965595172017, 6904.791661459224, 6949.166100067999, 6872.244053154149, 6873.037774711544, 6877.690503927335, 6878.7248510059535, 6888.001239820223, 6591.5056370772145, 6836.213835408942, 6836.897446538306, 6847.246802851682, 6867.656617169147, 6385.042243663441, 6391.0, 6402.263739669951, 6407.295197528269, 6414.198225221848, 30379.392412151632, 30846.53730194049, 30913.845430772926, 30918.845405773052, 30928.8453557733, 2178.7385513738295, 2193.4954960359046, 2216.9224077157223, 2218.944526386837, 2222.9888850555644, 20106.597868042558, 20711.689324660143, 20857.68713469299, 20870.686939695915, 20936.057877395553, 2476.938076548083, 2497.500499900027, 2550.655661485694, 2588.896444142232, 2610.464854704781, 136363.0, 141654.0, 142740.28629856888, 154024.0, 160234.0, 16068.598285042734, 16614.916925415295, 16669.91665041691, 16743.497695069167, 16781.160941952854, 26386.86806565955, 26433.0, 26460.0738974135, 26481.33796655099, 26501.072462463722, 10837.0, 10862.891371086345, 10901.890981090246, 10940.398278094623, 11018.614348497764, 9817.852732209023, 9823.656172033945, 9875.654352097643, 9885.555150018266, 9978.351407158512, 10017.39895606266, 10213.438260895722, 10357.689269321932, 10371.533281002223, 10377.481125943672, 2909.170886297395, 2909.185428080141, 2921.45043771814, 2952.896648617288, 3030.757539396843, 1015.9746006349752, 1039.9220058495644, 1044.770150566874, 1047.3925123428546, 1065.211743309945, 21513.78486215149, 21557.78442215589, 21763.564728705653, 21899.124035038738, 22447.0, 1086.380762965118, 1089.2375337263948, 1100.7578332766939, 1107.2470719910539, 1123.640435060789, 11955.820662690066, 12174.878251217551, 12198.02415806751, 12207.572734954234, 12248.142630015813, 578664.0, 606840.0, 614819.0, 617766.0, 624332.0, 129458.0, 133461.33269333592, 133525.0, 133818.99049129165, 134601.0, 1117.5920788911988, 1162.9011534019703, 1203.4825025239056, 1229.8893099620898, 1264.50684233151, 23701.407464812826, 23727.762722372554, 23916.40208994789, 24091.63862542028, 24176.63735044011, 62837.37162628315, 63734.36265637284, 63886.0, 64778.35221647723, 66386.0, 81283.18716812757, 83792.0, 83900.16099838924, 83962.0, 85519.5724021376, 15927.920360398588, 15993.0, 16072.437464688679, 16166.272517736496, 16168.949018313771, 22418.215362462237, 25295.36761580975, 25789.0, 25814.612780807925, 25897.352566185997, 17211.56971075683, 17256.913715431343, 17290.0, 20075.79924200798, 20530.897345513178, 17893.463196104138, 18275.36036238725, 18307.908460458144, 18467.984260865782, 18778.718319225496, 20945.790542094383, 21132.894335528224, 21243.46891327729, 21270.36188914335, 21566.460838479165, 16004.199790010685, 16065.0, 16090.839091608934, 16099.75850362269, 16366.509004729876, 20280.391588252376, 20442.0, 20499.69250461274, 20537.589248215252, 20549.89725051365], "value": 13053.398014775697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.4120128344812, 1447.6308541321962, 1471.9043262187963, 1488.8362280149188, 1493.223523767641, 16503.587410314747, 17116.828831711693, 17147.14264286784, 17154.056526891018, 17165.0, 16643.750343744825, 16685.582860428465, 16691.49925502237, 16691.749623755655, 16762.32950681971, 2739.917802465919, 2746.231055304518, 2783.582462630601, 2786.9442611147765, 2787.7212278772163, 2696.9460610787773, 2738.7672047875953, 2741.0, 2747.615333853262, 2749.3539018330675, 2704.377993061597, 2713.986430067847, 2720.3471166919994, 2825.0, 2836.6170566973506, 2717.565189569669, 2735.261479400551, 2736.5621500559814, 2740.8081434299606, 2742.424090940895, 2632.723564025769, 2663.973360266392, 2703.526882795503, 2707.458508298348, 2708.647875776156, 16540.255688493926, 16713.247903844356, 16714.16429178536, 16719.749203761952, 16726.66546669072, 8143.877841832377, 8381.161883811632, 8395.28640065589, 8397.370197235232, 8402.705905293285, 5361.169018802092, 5545.889082218373, 5589.133684278943, 5602.187682785973, 5616.073347897592, 2133.25336132354, 2154.504463973279, 2160.092761040367, 2204.790544898232, 2211.5355775287208, 30486.390272194654, 30765.077047688606, 30791.84604076965, 30811.45942702856, 30858.0, 6754.93245067543, 6889.414399775975, 6924.099867017357, 7054.2240353561065, 7063.117110361205, 19431.902840485705, 19710.60578788416, 19717.112729927187, 19728.70406943897, 19735.703964440545, 8148.470349427268, 8416.957915210507, 8419.200175983271, 8426.915730842737, 8431.536265505334, 7661.770146895602, 7716.459847810599, 7763.223677632304, 7791.649375778104, 7796.142424333319, 5451.972740136274, 5559.305086864142, 5671.177679236487, 5700.8004719835435, 5702.230198923092, 1554.1840533719887, 1590.1810567557718, 1590.6103004763675, 1593.1158207194887, 1593.8326475720114, 927.679950417105, 950.2445555783031, 959.0936564946059, 965.888922773876, 972.7373609125497, 9051.094890510896, 9209.631614735335, 9254.213391861633, 9298.256139508823, 9453.385529940531, 770.7302444144505, 778.696308439709, 785.9135495095535, 792.1919641965163, 801.1587832775679, 5041.2438134280155, 5313.681179129265, 5822.563307751935, 5833.67914764692, 6016.458518733335, 24297.0, 24498.0, 24840.0, 25340.366490837878, 25381.746182538307, 24701.38246543815, 25066.498670026496, 25261.62107568388, 25283.873580632346, 25333.240002799947, 11907.345096019802, 12115.575954841539, 12146.089043321786, 12215.633530993906, 12298.692532686755, 8786.692465763668, 9214.124658157465, 9283.164515193665, 9355.0, 9383.061693830836, 20874.582508350053, 21039.263625773023, 21142.260020899193, 21411.35765927025, 21761.0, 21731.674024889322, 22079.889600551895, 22092.11631534785, 22144.2249521266, 22211.22260720867, 12135.393230338272, 12332.260064396165, 12334.50661973511, 12393.62819115428, 12402.25586464815, 15307.846921530641, 15400.614984625026, 15417.922910385376, 15473.148976806384, 15473.922630386776, 12109.939450302692, 12482.812757808459, 12498.312592807482, 12548.686282843002, 12614.432350544432, 12084.939575302067, 12251.203671761306, 12376.381180940736, 12554.0, 12594.433250503933, 10647.0, 10982.835257470984, 10986.505607247853, 10987.285826421257, 11016.228863979444, 7882.251186137308, 7902.920970790448, 7928.207179282025, 8040.5979701015885, 8139.959300203698, 8132.430729848854, 8158.796030099295, 8163.918360816316, 8172.7956801080445, 8219.054808697076], "value": 7186.610039969584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.6892533405293, 562.5246666566751, 562.7073921560791, 567.2540609099035, 573.8393249890032, 6199.0, 6199.132121502993, 6218.37816218378, 6278.497720182386, 6368.363163683635, 6154.846128846781, 6216.222972128484, 6256.468200202989, 6261.436470717635, 6265.906011409821, 5081.59347252219, 5099.184130539114, 5118.59051275897, 5122.0, 5145.3568303962, 4997.425296090942, 5038.420581633122, 5155.633757054384, 5156.793728250866, 5157.123289040854, 4799.0725657348985, 4871.756412179395, 5086.593072554187, 5101.362329708786, 5113.744312784364, 4956.9428687095, 4957.603391728653, 4971.45314015458, 4984.252362145689, 4989.600831933437, 4428.557144285545, 4451.888702782424, 4466.196084704752, 4498.482674492409, 4511.939694171867, 6018.96990515049, 6031.577789554733, 6084.26988761347, 6108.236470441195, 6119.694015299217, 5793.7972170974235, 5875.794347197871, 5875.882482350372, 5901.911471327933, 5910.763569457216, 6432.131662225634, 6559.6064236145985, 6567.277599464055, 6589.538732288742, 6615.0, 4979.950200497985, 4988.90022199554, 5007.84976450707, 5048.939722658246, 5057.974710126426, 6675.299093595199, 6760.594364338155, 6788.253292137911, 6892.517523773338, 6918.688659010306, 5156.819511317086, 5189.247559103985, 5189.584833213334, 5213.296205012275, 5214.817481388209, 5213.582913366921, 5213.843584692389, 5238.214267859851, 5311.867203319948, 5312.73436328182, 5790.710464476843, 5804.245448091721, 5834.212381328552, 5839.299284085937, 5892.558058145656, 6609.570377925419, 6610.950605312369, 6622.63575503352, 6658.9001164982565, 6670.0, 1781.1361489677497, 1817.7727784026997, 1827.3238901606226, 1835.752173456593, 1846.4922146409576, 1244.9688757780946, 1273.19152338264, 1286.5462027908404, 1312.8162057311984, 1321.3129172830268, 6180.381961803783, 6191.318954914956, 6221.160143380585, 6236.345183755731, 6253.812385628438, 6518.598501322239, 6544.672766361663, 6637.0, 6653.733850646016, 6712.42944349726, 6054.788082417094, 6100.450959413674, 6101.664408457577, 6177.567570270038, 6205.193324867739, 3494.9301013980084, 3505.914794980452, 3511.1741894215374, 3528.6118526962014, 3543.344481270973, 6877.386593094692, 6899.93100069003, 7017.614031228331, 7025.508214424941, 7056.5775598834525, 6892.4836535962, 6912.308769123148, 6917.51577389588, 6924.757633482804, 7002.529468811505, 6959.930400696029, 6969.407600353925, 7004.824879378057, 7018.999999999898, 7040.6479676016, 6642.0, 6678.532502724763, 6680.866382672222, 6748.325167483213, 6811.795646130624, 6618.338166183343, 6695.564788288746, 6706.66466676674, 6715.496337774589, 6720.6975686093265, 6987.790366289019, 7035.401990830836, 7055.118110236221, 7056.964715176391, 7085.539439936388, 5177.119889618699, 5208.401033881152, 5222.582193424441, 5226.63413561047, 5229.954009198252, 6518.120053792677, 6597.241317248578, 6667.899981500184, 6695.397414232742, 6762.594244345355, 6472.546921715623, 6529.771457998947, 6576.572522786004, 6583.572067815769, 6595.967020164869, 6456.644884531396, 6520.608763474207, 6523.24982627004, 6537.607743535403, 6596.208454985433, 6344.333844946214, 6397.680115994275, 6412.903806442814, 6490.902636460362, 6500.577462464925, 6520.18497687789, 6540.705668244846, 6625.933740662532, 6682.766103186365, 6716.126903502513, 6401.93598064032, 6425.453836423956, 6462.838429039311, 6480.967595161994, 6520.902186467112], "value": 5169.186227308394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.4136788610774, 988.7111337254256, 1004.0662184168725, 1016.5273147986187, 1021.0657248617506, 20403.387898363053, 21081.683774743393, 21175.894120529396, 21188.0, 21193.152273909065, 19040.238390464365, 19314.903425482888, 19316.90341548294, 19325.613487730236, 19328.90335548324, 1025.4206373399043, 1050.0916707048386, 1050.4117694091294, 1050.5220124843179, 1050.768830857214, 974.6198982396871, 978.5107446276861, 978.7699890525721, 982.4449186209769, 983.6655537117379, 1012.7492546704814, 1134.625573560723, 1135.7160709822545, 1140.680609429357, 1140.954361825526, 1127.780082883838, 1129.3788416371003, 1130.559081958037, 1132.4620805117586, 1133.1501373969522, 779.2597032818845, 799.7960520067346, 803.7829785957758, 804.0833449867156, 804.2801692485251, 19311.227550897947, 19361.9031904841, 19414.22343106274, 19419.417417477358, 19485.707714384294, 21506.462338441506, 21641.0, 21696.457588560414, 21981.780182198294, 22012.119515219372, 17680.469585912444, 17714.91142544279, 17829.643407131785, 17959.56323494117, 18052.54868628282, 3854.3447613905705, 3859.4982652255308, 3874.8256328465286, 3874.9612503874882, 3885.2229554089013, 131225.0, 163074.0, 164343.17828410902, 166365.0, 168582.99999999878, 16389.262483188286, 17411.56471088233, 17644.823551764573, 17679.469615911545, 17774.377896773552, 27192.0, 27402.0, 27533.724662753117, 27583.0, 27625.72374276272, 9453.952730236304, 9477.336586439022, 9529.0, 9571.61713531451, 9583.281253905985, 4433.933490997638, 4529.6376289896725, 4547.909041819145, 4550.863474095782, 4551.931721024187, 5909.940900591025, 6007.369226231182, 6067.7269522871575, 6067.969660151759, 6094.390560943959, 1170.8126699728002, 1203.284045992633, 1219.945102470391, 1223.577865636354, 1224.6815827884636, 738.151126204858, 744.6835095084567, 752.5409500204871, 770.9691612335444, 772.0118248641747, 13332.93333533326, 13846.653833654038, 14131.434742610387, 14504.782428263585, 14541.854581454261, 737.181728281607, 744.3301029073768, 747.9065116860393, 763.4426868386109, 764.399946042354, 6296.464800492009, 6309.558330916791, 6354.809355719336, 6421.486281097501, 6426.518011149183, 144316.0, 144959.2752036254, 146142.269288655, 147393.0, 147476.0, 128105.35947320204, 128520.0, 130330.34834825955, 132514.0, 136660.0, 114413.0, 114621.0, 114775.85224147819, 115947.42026289983, 119063.0, 11976.940115299367, 11980.640580782241, 12044.21712588679, 12065.51737930508, 12070.939645301718, 56232.43767562436, 56729.71635141798, 56990.43009569851, 57228.0, 58087.419125809894, 72587.0, 72659.27340726525, 73938.63030685027, 76188.61905690435, 77198.0, 17506.474805755846, 17935.461936141935, 17943.371981980566, 18018.639627207645, 18067.638647227246, 16254.918725406298, 16540.586485337964, 16646.75029874577, 16679.49961501157, 16741.581460463585, 17230.913845430692, 17351.56621084483, 17519.649607008043, 17520.474385768448, 17650.470485885446, 16609.584760381087, 16733.581660458098, 16832.326706931584, 16988.235529401452, 17073.231704573573, 17027.7445838315, 17294.13529323554, 17301.740473893155, 17345.739813903056, 17368.565785855455, 11092.22354435214, 11174.27367221128, 11232.606858759904, 11311.377874216998, 11351.14866385008, 12234.938825305817, 12273.140880138304, 12453.688657783629, 12543.686407839512, 12686.873131268938], "value": 9715.782149937286, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1387.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 106.0, 105.0, 106.0, 108.0, 106.0, 109.0, 105.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 112.0, 116.0, 129.0, 113.0, 142.0, 114.0, 136.0, 115.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 159.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 172.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 80.0, 74.0, 73.0, 72.0, 72.0, 73.0, 74.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 80.0, 77.0, 79.0, 78.0, 79.0, 79.0, 84.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 155.0, 149.0, 150.0, 150.0, 152.0, 151.0, 150.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 93.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 44.0, 46.0, 46.0, 49.0, 47.0, 44.0, 46.0, 45.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 37.0, 36.0, 36.0, 37.0, 37.0, 36.0, 36.0, 36.0], "value": 36.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 73.0, 73.0, 72.0, 71.0, 71.0, 70.0, 75.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 116.0, 114.0, 117.0, 109.0, 108.0, 116.0, 107.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 172.0, 156.0, 158.0, 152.0, 152.0, 159.0, 156.0, 154.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 57.0, 57.0, 66.0, 58.0], "value": 59.1, "unit": "score"}]}]} 04:21:53 INFO - Return code: 0 04:21:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:21:53 INFO - # TBPL SUCCESS # 04:21:53 INFO - Running post-action listener: _package_coverage_data 04:21:53 INFO - Running post-action listener: _resource_record_post_action 04:21:53 INFO - [mozharness: 2017-09-09 11:21:53.815189Z] Finished run-tests step (success) 04:21:53 INFO - Running post-run listener: _resource_record_post_run 04:21:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 304877568; Read time: 0; Write time: 158368 04:21:53 INFO - TinderboxPrint: CPU usage
13.1% 04:21:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:21:53 INFO - TinderboxPrint: I/O write bytes / time
304,877,568 / 158,368 04:21:53 INFO - TinderboxPrint: CPU idle
8,214.2 (86.9%) 04:21:53 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 04:21:53 INFO - TinderboxPrint: Swap in / out
0 / 0 04:21:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12578816; Read time: 0; Write time: 3236 04:21:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:21:53 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 292298752; Read time: 0; Write time: 155132 04:21:54 INFO - Running post-run listener: _upload_blobber_files 04:21:54 INFO - Blob upload gear active. 04:21:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21: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 04:21: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:55 INFO - (blobuploader) - INFO - Done attempting. 04:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:02 INFO - (blobuploader) - INFO - Done attempting. 04:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:22:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:03 INFO - (blobuploader) - INFO - Done attempting. 04:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:04 INFO - (blobuploader) - INFO - Done attempting. 04:22:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:04 INFO - Return code: 0 04:22:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5eee217f9951f59625bf94400000a0453aee790c150e784c80fc465fc9b648ec8ffeaed7e18deec1faac1d0f3600c17cbd658b3d5021c7e3ace7f482fb83d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71235b18220c853d4103cdf0de8b07ce39e079ffb191137fda786368d213a3c0e1070ff00746b3664cc1b13f940aebf3de3d71e13275a467f94225b4f53ccf46", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/484559dc6ebeefb95fb1cb1d8c1c1a866fd792c981f1cf13005b34c1d237e387763251cd7553eb8097cbdb2c5e3f5649c7e085e03e56eeaeedf7f804ab3d31f9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb47bc7b2428c22eeb6131717feb75819fdf20d4791452a2cdffefffb4958e031d60b0bd26b87ed8da6451c3e9ede0ccefb20d69d164b7238e0e6fa95615184"} 04:22:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:04 INFO - Contents: 04:22:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5eee217f9951f59625bf94400000a0453aee790c150e784c80fc465fc9b648ec8ffeaed7e18deec1faac1d0f3600c17cbd658b3d5021c7e3ace7f482fb83d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71235b18220c853d4103cdf0de8b07ce39e079ffb191137fda786368d213a3c0e1070ff00746b3664cc1b13f940aebf3de3d71e13275a467f94225b4f53ccf46", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/484559dc6ebeefb95fb1cb1d8c1c1a866fd792c981f1cf13005b34c1d237e387763251cd7553eb8097cbdb2c5e3f5649c7e085e03e56eeaeedf7f804ab3d31f9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb47bc7b2428c22eeb6131717feb75819fdf20d4791452a2cdffefffb4958e031d60b0bd26b87ed8da6451c3e9ede0ccefb20d69d164b7238e0e6fa95615184"} 04:22:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:04 INFO - Copying logs to upload dir... 04:22:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.705434 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-09 04:22:04.831782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:04.840306) ========= 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=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5eee217f9951f59625bf94400000a0453aee790c150e784c80fc465fc9b648ec8ffeaed7e18deec1faac1d0f3600c17cbd658b3d5021c7e3ace7f482fb83d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71235b18220c853d4103cdf0de8b07ce39e079ffb191137fda786368d213a3c0e1070ff00746b3664cc1b13f940aebf3de3d71e13275a467f94225b4f53ccf46", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/484559dc6ebeefb95fb1cb1d8c1c1a866fd792c981f1cf13005b34c1d237e387763251cd7553eb8097cbdb2c5e3f5649c7e085e03e56eeaeedf7f804ab3d31f9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb47bc7b2428c22eeb6131717feb75819fdf20d4791452a2cdffefffb4958e031d60b0bd26b87ed8da6451c3e9ede0ccefb20d69d164b7238e0e6fa95615184"} build_url:https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/HkGfihTsQnqFjbjqcJcq_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5eee217f9951f59625bf94400000a0453aee790c150e784c80fc465fc9b648ec8ffeaed7e18deec1faac1d0f3600c17cbd658b3d5021c7e3ace7f482fb83d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71235b18220c853d4103cdf0de8b07ce39e079ffb191137fda786368d213a3c0e1070ff00746b3664cc1b13f940aebf3de3d71e13275a467f94225b4f53ccf46", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/484559dc6ebeefb95fb1cb1d8c1c1a866fd792c981f1cf13005b34c1d237e387763251cd7553eb8097cbdb2c5e3f5649c7e085e03e56eeaeedf7f804ab3d31f9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fb47bc7b2428c22eeb6131717feb75819fdf20d4791452a2cdffefffb4958e031d60b0bd26b87ed8da6451c3e9ede0ccefb20d69d164b7238e0e6fa95615184"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:04.868664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:04.868996) ========= 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=dac658600622fd96716c9acf000001b3-1504954538.439132-353580130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:22:04.951660) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:22:04.954979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:22:04.955271) ========= ========= Total master_lag: 1.80 =========