builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-019 starttime: 1506988770.42 results: success (0) revision: 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.422903) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.423742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.424229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.495008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.495301) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 16:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.2M=0s 2017-10-02 16:59:30 (99.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185561 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.736932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.737276) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020898 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.788217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:30.788568) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad --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 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad --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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 16:59:30,852 truncating revision to first 12 chars 2017-10-02 16:59:30,852 Setting DEBUG logging. 2017-10-02 16:59:30,852 attempt 1/10 2017-10-02 16:59:30,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f66e0613bd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 16:59:31,247 unpacking tar archive at: mozilla-central-8f66e0613bd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:31.556070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:31.556376) ========= script_repo_revision: 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:31.556777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:31.557038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:59:31.570008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 16:59:31.570334) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:31 INFO - MultiFileLogger online at 20171002 16:59:31 in /builds/slave/test 16:59:31 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 16:59:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:31 INFO - {'append_to_log': False, 16:59:31 INFO - 'base_work_dir': '/builds/slave/test', 16:59:31 INFO - 'blob_upload_branch': 'Firefox', 16:59:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:31 INFO - 'branch': 'Firefox', 16:59:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:31 INFO - 'code_coverage': False, 16:59:31 INFO - 'config_files': ('talos/linux_config.py',), 16:59:31 INFO - 'default_actions': ('clobber', 16:59:31 INFO - 'read-buildbot-config', 16:59:31 INFO - 'download-and-extract', 16:59:31 INFO - 'populate-webroot', 16:59:31 INFO - 'create-virtualenv', 16:59:31 INFO - 'install', 16:59:31 INFO - 'setup-mitmproxy', 16:59:31 INFO - 'run-tests'), 16:59:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:31 INFO - 'disable_ccov_upload': False, 16:59:31 INFO - 'disable_stylo': False, 16:59:31 INFO - 'download_minidump_stackwalk': True, 16:59:31 INFO - 'download_symbols': 'ondemand', 16:59:31 INFO - 'enable_stylo': False, 16:59:31 INFO - 'enable_webrender': False, 16:59:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:59:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:31 INFO - 'gecko_profile': False, 16:59:31 INFO - 'gecko_profile_interval': 0, 16:59:31 INFO - 'installer_path': 'installer.exe', 16:59:31 INFO - 'log_level': 'info', 16:59:31 INFO - 'log_name': 'talos', 16:59:31 INFO - 'log_to_console': True, 16:59:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:31 INFO - 'opt_config_files': (), 16:59:31 INFO - 'pip_index': False, 16:59:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:59:31 INFO - 'system_bits': '32', 16:59:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:31 INFO - 'title': 'talos-linux64-ix-019', 16:59:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:31 INFO - 'use_talos_json': True, 16:59:31 INFO - 'verify': 'False', 16:59:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:31 INFO - 'work_dir': 'build'} 16:59:31 INFO - [mozharness: 2017-10-02 23:59:31.853554Z] Running clobber step. 16:59:31 INFO - Running pre-action listener: _resource_record_pre_action 16:59:31 INFO - Running main action method: clobber 16:59:31 INFO - rmtree: /builds/slave/test/build 16:59:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:32 INFO - Running post-action listener: _resource_record_post_action 16:59:32 INFO - [mozharness: 2017-10-02 23:59:32.793971Z] Finished clobber step (success) 16:59:32 INFO - [mozharness: 2017-10-02 23:59:32.794069Z] Running read-buildbot-config step. 16:59:32 INFO - Running pre-action listener: _resource_record_pre_action 16:59:32 INFO - Running main action method: read_buildbot_config 16:59:32 INFO - Using buildbot properties: 16:59:32 INFO - { 16:59:32 INFO - "project": "", 16:59:32 INFO - "product": "firefox", 16:59:32 INFO - "who": "ryanvm@gmail.com", 16:59:32 INFO - "installer_path": "public/build/target.tar.bz2", 16:59:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:59:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:59:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:59:32 INFO - "stage_platform": "linux64-pgo", 16:59:32 INFO - "basedir": "/builds/slave/test", 16:59:32 INFO - "buildnumber": 48, 16:59:32 INFO - "platform": "ubuntu64_hw", 16:59:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:59:32 INFO - "slavebuilddir": "test", 16:59:32 INFO - "taskId": "VucCs4Y4TMivfLBitxA_bA", 16:59:32 INFO - "branch": "mozilla-central", 16:59:32 INFO - "script_repo_revision": "production", 16:59:32 INFO - "revision": "8f66e0613bd3b1fabb003f970bfe54fd0804e4ad", 16:59:32 INFO - "slavename": "talos-linux64-ix-019", 16:59:32 INFO - "repo_path": "mozilla-central" 16:59:32 INFO - } 16:59:32 INFO - Finding installer, test and symbols from parent task. 16:59:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VucCs4Y4TMivfLBitxA_bA'}, attempt #1 16:59:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VucCs4Y4TMivfLBitxA_bA'}, attempt #1 16:59:33 INFO - Task dependencies: JOL-TkI-RMSclPLlj1z2Uw 16:59:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw'}, attempt #1 16:59:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 16:59:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.test_packages.json 16:59:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.crashreporter-symbols.zip 16:59:34 INFO - Running post-action listener: _resource_record_post_action 16:59:34 INFO - [mozharness: 2017-10-02 23:59:34.447465Z] Finished read-buildbot-config step (success) 16:59:34 INFO - [mozharness: 2017-10-02 23:59:34.447683Z] Running download-and-extract step. 16:59:34 INFO - Running pre-action listener: _resource_record_pre_action 16:59:34 INFO - Running main action method: download_and_extract 16:59:34 INFO - mkdir: /builds/slave/test/build/tests 16:59:34 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')]} 16:59:34 INFO - trying https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.test_packages.json 16:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:59:35 INFO - Downloaded 989 bytes. 16:59:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:59:35 INFO - Using the following test package requirements: 16:59:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:59:35 INFO - u'common': [u'target.common.tests.zip'], 16:59:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:59:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:59:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:59:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:59:35 INFO - u'mozbase': [u'target.common.tests.zip'], 16:59:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:59:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:59:35 INFO - u'web-platform': [u'target.common.tests.zip', 16:59:35 INFO - u'target.web-platform.tests.tar.gz'], 16:59:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:59:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.common.tests.zip 16:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.common.tests.zip into memory 16:59:36 INFO - Content-Length response header: 55920267 16:59:36 INFO - Bytes received: 55920267 16:59:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.talos.tests.zip 16:59:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:59:47 INFO - Fetch https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.talos.tests.zip into memory 16:59:48 INFO - Content-Length response header: 14522385 16:59:48 INFO - Bytes received: 14522385 16:59: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')]} 16:59:48 INFO - trying https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 16:59:48 INFO - Downloading https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:59:49 INFO - Downloaded 62345773 bytes. 16:59:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 16:59:49 INFO - mkdir: /builds/slave/test/properties 16:59:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:49 INFO - Contents: 16:59:49 INFO - build_url:https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 16:59:49 INFO - Running post-action listener: _resource_record_post_action 16:59:49 INFO - Running post-action listener: find_tests_for_verification 16:59:49 INFO - Running post-action listener: set_extra_try_arguments 16:59:49 INFO - [mozharness: 2017-10-02 23:59:49.620732Z] Finished download-and-extract step (success) 16:59:49 INFO - [mozharness: 2017-10-02 23:59:49.620829Z] Running populate-webroot step. 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: populate_webroot 16:59:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['tresize', 16:59:49 INFO - 'tcanvasmark']}, 16:59:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['dromaeo_css', 16:59:49 INFO - 'kraken']}, 16:59:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'tests': ['damp', 'tps']}, 16:59:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['damp', 'tps']}, 16:59:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['dromaeo_dom']}, 16:59:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:59:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['basic_compositor_video', 16:59:49 INFO - 'glvideo']}, 16:59:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:59:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['ts_paint_webext', 16:59:49 INFO - 'tp5o_webext']}, 16:59:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:49 INFO - 'ts_paint', 16:59:49 INFO - 'tpaint', 16:59:49 INFO - 'sessionrestore', 16:59:49 INFO - 'sessionrestore_many_windows', 16:59:49 INFO - 'sessionrestore_no_auto_restore', 16:59:49 INFO - 'tabpaint', 16:59:49 INFO - 'cpstartup']}, 16:59:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['a11yr', 16:59:49 INFO - 'ts_paint', 16:59:49 INFO - 'tpaint', 16:59:49 INFO - 'sessionrestore', 16:59:49 INFO - 'sessionrestore_many_windows', 16:59:49 INFO - 'sessionrestore_no_auto_restore', 16:59:49 INFO - 'tabpaint', 16:59:49 INFO - 'cpstartup']}, 16:59:49 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:59:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:59:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['perf_reftest_singletons']}, 16:59:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['perf_reftest']}, 16:59:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:49 INFO - 'tsvgr_opacity', 16:59:49 INFO - 'tart', 16:59:49 INFO - 'tscrollx', 16:59:49 INFO - 'tsvg_static']}, 16:59:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['tsvgx', 16:59:49 INFO - 'tsvgr_opacity', 16:59:49 INFO - 'tart', 16:59:49 INFO - 'tscrollx', 16:59:49 INFO - 'tsvg_static']}, 16:59:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:59:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--disable-stylo'], 16:59:49 INFO - 'tests': ['tp5o']}, 16:59:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:59:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:59:49 INFO - 'talos_options': ['--mitmproxy', 16:59:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:59:49 INFO - '--firstNonBlankPaint'], 16:59:49 INFO - 'tests': ['tp6_google', 16:59:49 INFO - 'tp6_youtube', 16:59:49 INFO - 'tp6_amazon', 16:59:49 INFO - 'tp6_facebook']}, 16:59:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:59:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:59:49 INFO - 'talos_options': ['--disable-stylo', 16:59:49 INFO - '--mitmproxy', 16:59:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:59:49 INFO - '--firstNonBlankPaint'], 16:59:49 INFO - 'tests': ['tp6_google', 16:59:49 INFO - 'tp6_youtube', 16:59:49 INFO - 'tp6_amazon', 16:59:49 INFO - 'tp6_facebook']}, 16:59:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:59:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:59:49 INFO - 'talos_options': ['--stylo-threads=1', 16:59:49 INFO - '--mitmproxy', 16:59:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:59:49 INFO - '--firstNonBlankPaint'], 16:59:49 INFO - 'tests': ['tp6_google', 16:59:49 INFO - 'tp6_youtube', 16:59:49 INFO - 'tp6_amazon', 16:59:49 INFO - 'tp6_facebook']}, 16:59:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--xperf_path', 16:59:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:49 INFO - 'tests': ['tp5n']}, 16:59:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:59:49 INFO - 'talos_options': ['--disable-stylo', 16:59:49 INFO - '--xperf_path', 16:59:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:49 INFO - 'tests': ['tp5n']}}} 16:59:49 INFO - Running post-action listener: _resource_record_post_action 16:59:49 INFO - [mozharness: 2017-10-02 23:59:49.636441Z] Finished populate-webroot step (success) 16:59:49 INFO - [mozharness: 2017-10-02 23:59:49.636530Z] Running create-virtualenv step. 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: create_virtualenv 16:59:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:59:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:59:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:59:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:50 INFO - Installing pip...............done. 16:59:50 INFO - Return code: 0 16:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:59:50 INFO - Reading from file tmpfile_stdout 16:59:50 INFO - Output received: 16:59:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:59:50 INFO - Using env: {'DISPLAY': ':0', 16:59:50 INFO - 'HOME': '/home/cltbld', 16:59:50 INFO - 'LANG': 'en_US.UTF-8', 16:59:50 INFO - 'LANGUAGE': 'en_US:en', 16:59:50 INFO - 'LOGNAME': 'cltbld', 16:59:50 INFO - 'MAIL': '/var/mail/cltbld', 16:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:50 INFO - 'MOZ_NO_REMOTE': '1', 16:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:50 INFO - 'NO_EM_RESTART': '1', 16:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:50 INFO - 'PWD': '/builds/slave/test', 16:59:50 INFO - 'SHELL': '/bin/bash', 16:59:50 INFO - 'SHLVL': '1', 16:59:50 INFO - 'TERM': 'linux', 16:59:50 INFO - 'TMOUT': '86400', 16:59:50 INFO - 'USER': 'cltbld', 16:59:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:50 INFO - '_': '/tools/buildbot/bin/python'} 16:59:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:59:53 INFO - Downloading/unpacking pip>=1.5 16:59:53 INFO - Running setup.py egg_info for package pip 16:59:53 INFO - warning: no files found matching 'pip/cacert.pem' 16:59:53 INFO - warning: no files found matching '*.html' under directory 'docs' 16:59:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:59:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:59:53 INFO - Installing collected packages: pip 16:59:53 INFO - Found existing installation: pip 1.1 16:59:53 INFO - Uninstalling pip: 16:59:53 INFO - Successfully uninstalled pip 16:59:53 INFO - Running setup.py install for pip 16:59:53 INFO - warning: no files found matching 'pip/cacert.pem' 16:59:53 INFO - warning: no files found matching '*.html' under directory 'docs' 16:59:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:59:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:59:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:59:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:59:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:59:53 INFO - Successfully installed pip 16:59:53 INFO - Cleaning up... 16:59:53 INFO - Return code: 0 16:59:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:59:53 INFO - Using env: {'DISPLAY': ':0', 16:59:53 INFO - 'HOME': '/home/cltbld', 16:59:53 INFO - 'LANG': 'en_US.UTF-8', 16:59:53 INFO - 'LANGUAGE': 'en_US:en', 16:59:53 INFO - 'LOGNAME': 'cltbld', 16:59:53 INFO - 'MAIL': '/var/mail/cltbld', 16:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:53 INFO - 'MOZ_NO_REMOTE': '1', 16:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:53 INFO - 'NO_EM_RESTART': '1', 16:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:53 INFO - 'PWD': '/builds/slave/test', 16:59:53 INFO - 'SHELL': '/bin/bash', 16:59:53 INFO - 'SHLVL': '1', 16:59:53 INFO - 'TERM': 'linux', 16:59:53 INFO - 'TMOUT': '86400', 16:59:53 INFO - 'USER': 'cltbld', 16:59:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:53 INFO - '_': '/tools/buildbot/bin/python'} 16:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:53 INFO - Downloading/unpacking psutil>=3.1.1 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:54 INFO - Installing collected packages: psutil 16:59:54 INFO - Running setup.py install for psutil 16:59:54 INFO - building 'psutil._psutil_linux' extension 16:59:54 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 16:59:55 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 16:59:55 INFO - building 'psutil._psutil_posix' extension 16:59:55 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 16:59:55 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 16:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:56 INFO - Successfully installed psutil 16:59:56 INFO - Cleaning up... 16:59:56 INFO - Return code: 0 16:59:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59: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')]} 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:59: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 mozsystemmonitor==0.3 16:59:56 INFO - Using env: {'DISPLAY': ':0', 16:59:56 INFO - 'HOME': '/home/cltbld', 16:59:56 INFO - 'LANG': 'en_US.UTF-8', 16:59:56 INFO - 'LANGUAGE': 'en_US:en', 16:59:56 INFO - 'LOGNAME': 'cltbld', 16:59:56 INFO - 'MAIL': '/var/mail/cltbld', 16:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:56 INFO - 'MOZ_NO_REMOTE': '1', 16:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:56 INFO - 'NO_EM_RESTART': '1', 16:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:56 INFO - 'PWD': '/builds/slave/test', 16:59:56 INFO - 'SHELL': '/bin/bash', 16:59:56 INFO - 'SHLVL': '1', 16:59:56 INFO - 'TERM': 'linux', 16:59:56 INFO - 'TMOUT': '86400', 16:59:56 INFO - 'USER': 'cltbld', 16:59:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:56 INFO - '_': '/tools/buildbot/bin/python'} 16:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:59: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 16:59: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 16:59: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 16:59: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 16:59:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:59:57 INFO - Installing collected packages: mozsystemmonitor 16:59:57 INFO - Running setup.py install for mozsystemmonitor 16:59:57 INFO - Successfully installed mozsystemmonitor 16:59:57 INFO - Cleaning up... 16:59:57 INFO - Return code: 0 16:59:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59: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')]} 16:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59: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', '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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:59: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 jsonschema==2.5.1 16:59:57 INFO - Using env: {'DISPLAY': ':0', 16:59:57 INFO - 'HOME': '/home/cltbld', 16:59:57 INFO - 'LANG': 'en_US.UTF-8', 16:59:57 INFO - 'LANGUAGE': 'en_US:en', 16:59:57 INFO - 'LOGNAME': 'cltbld', 16:59:57 INFO - 'MAIL': '/var/mail/cltbld', 16:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:57 INFO - 'MOZ_NO_REMOTE': '1', 16:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:57 INFO - 'NO_EM_RESTART': '1', 16:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:57 INFO - 'PWD': '/builds/slave/test', 16:59:57 INFO - 'SHELL': '/bin/bash', 16:59:57 INFO - 'SHLVL': '1', 16:59:57 INFO - 'TERM': 'linux', 16:59:57 INFO - 'TMOUT': '86400', 16:59:57 INFO - 'USER': 'cltbld', 16:59:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:57 INFO - '_': '/tools/buildbot/bin/python'} 16:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:59: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 16:59: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 16:59: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 16:59: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 16:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:59: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 16:59: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 16:59: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 16:59: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 16:59:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:59 INFO - warning: no files found matching '*.txt' 16:59:59 INFO - no previously-included directories found matching 'build' 16:59:59 INFO - no previously-included directories found matching 'dist' 16:59:59 INFO - no previously-included directories found matching '.git*' 16:59:59 INFO - Installing collected packages: jsonschema, functools32 16:59:59 INFO - Running setup.py install for functools32 16:59:59 INFO - warning: no files found matching '*.txt' 16:59:59 INFO - no previously-included directories found matching 'build' 16:59:59 INFO - no previously-included directories found matching 'dist' 16:59:59 INFO - no previously-included directories found matching '.git*' 16:59:59 INFO - Successfully installed jsonschema functools32 16:59:59 INFO - Cleaning up... 16:59:59 INFO - Return code: 0 16:59:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59: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')]} 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:59 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59:59 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 16:59:59 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 16:59:59 INFO - Using env: {'DISPLAY': ':0', 16:59:59 INFO - 'HOME': '/home/cltbld', 16:59:59 INFO - 'LANG': 'en_US.UTF-8', 16:59:59 INFO - 'LANGUAGE': 'en_US:en', 16:59:59 INFO - 'LOGNAME': 'cltbld', 16:59:59 INFO - 'MAIL': '/var/mail/cltbld', 16:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:59 INFO - 'MOZ_NO_REMOTE': '1', 16:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:59 INFO - 'NO_EM_RESTART': '1', 16:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:59 INFO - 'PWD': '/builds/slave/test', 16:59:59 INFO - 'SHELL': '/bin/bash', 16:59:59 INFO - 'SHLVL': '1', 16:59:59 INFO - 'TERM': 'linux', 16:59:59 INFO - 'TMOUT': '86400', 16:59:59 INFO - 'USER': 'cltbld', 16:59:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:59 INFO - '_': '/tools/buildbot/bin/python'} 16:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:59:59 INFO - Cleaning up... 16:59:59 INFO - Return code: 0 16:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59: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')]} 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:59 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 16:59:59 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 16:59:59 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 16:59:59 INFO - Using env: {'DISPLAY': ':0', 16:59:59 INFO - 'HOME': '/home/cltbld', 16:59:59 INFO - 'LANG': 'en_US.UTF-8', 16:59:59 INFO - 'LANGUAGE': 'en_US:en', 16:59:59 INFO - 'LOGNAME': 'cltbld', 16:59:59 INFO - 'MAIL': '/var/mail/cltbld', 16:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:59 INFO - 'MOZ_NO_REMOTE': '1', 16:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:59 INFO - 'NO_EM_RESTART': '1', 16:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:59 INFO - 'PWD': '/builds/slave/test', 16:59:59 INFO - 'SHELL': '/bin/bash', 16:59:59 INFO - 'SHLVL': '1', 16:59:59 INFO - 'TERM': 'linux', 16:59:59 INFO - 'TMOUT': '86400', 16:59:59 INFO - 'USER': 'cltbld', 16:59:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 16:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:59 INFO - '_': '/tools/buildbot/bin/python'} 16:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:01 INFO - Downloading docopt-0.6.1.tar.gz 17:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:01 INFO - Running setup.py install for blobuploader 17:00:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:01 INFO - Running setup.py install for requests 17:00:01 INFO - Running setup.py install for docopt 17:00:02 INFO - Successfully installed blobuploader requests docopt 17:00:02 INFO - Cleaning up... 17:00:02 INFO - Return code: 0 17:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00: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')]} 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:02 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 17:00:02 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 17:00:02 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 17:00:02 INFO - Using env: {'DISPLAY': ':0', 17:00:02 INFO - 'HOME': '/home/cltbld', 17:00:02 INFO - 'LANG': 'en_US.UTF-8', 17:00:02 INFO - 'LANGUAGE': 'en_US:en', 17:00:02 INFO - 'LOGNAME': 'cltbld', 17:00:02 INFO - 'MAIL': '/var/mail/cltbld', 17:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:02 INFO - 'MOZ_NO_REMOTE': '1', 17:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:02 INFO - 'NO_EM_RESTART': '1', 17:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:02 INFO - 'PWD': '/builds/slave/test', 17:00:02 INFO - 'SHELL': '/bin/bash', 17:00:02 INFO - 'SHLVL': '1', 17:00:02 INFO - 'TERM': 'linux', 17:00:02 INFO - 'TMOUT': '86400', 17:00:02 INFO - 'USER': 'cltbld', 17:00:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:02 INFO - '_': '/tools/buildbot/bin/python'} 17:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:02 INFO - Running setup.py (path:/tmp/pip-OEnPjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:02 INFO - Running setup.py (path:/tmp/pip-wc3Gmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:02 INFO - Running setup.py (path:/tmp/pip-UDO0Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:02 INFO - Running setup.py (path:/tmp/pip-k7zW7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:02 INFO - Running setup.py (path:/tmp/pip-qszOyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:02 INFO - Running setup.py (path:/tmp/pip-g0VpHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:02 INFO - Running setup.py (path:/tmp/pip-_u72kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:02 INFO - Running setup.py (path:/tmp/pip-3oIkRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:02 INFO - Running setup.py (path:/tmp/pip-1700Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:02 INFO - Running setup.py (path:/tmp/pip-GxXoVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:02 INFO - Running setup.py (path:/tmp/pip-PZjSQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:03 INFO - Running setup.py (path:/tmp/pip-EC0OIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:03 INFO - Running setup.py (path:/tmp/pip-gWbkN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:03 INFO - Running setup.py (path:/tmp/pip-yizzij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:03 INFO - Running setup.py (path:/tmp/pip-nbh_Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:03 INFO - Running setup.py (path:/tmp/pip-v2IxcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:03 INFO - Running setup.py (path:/tmp/pip-Wm5GHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:03 INFO - Running setup.py install for manifestparser 17:00:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:03 INFO - Running setup.py install for mozcrash 17:00:03 INFO - Running setup.py install for mozdebug 17:00:03 INFO - Running setup.py install for mozdevice 17:00:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:03 INFO - Running setup.py install for mozfile 17:00:03 INFO - Running setup.py install for mozhttpd 17:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozinfo 17:00:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozInstall 17:00:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozleak 17:00:04 INFO - Running setup.py install for mozlog 17:00:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for moznetwork 17:00:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozprocess 17:00:04 INFO - Running setup.py install for mozprofile 17:00:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozrunner 17:00:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:04 INFO - Running setup.py install for mozscreenshot 17:00:05 INFO - Running setup.py install for moztest 17:00:05 INFO - Running setup.py install for mozversion 17:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:05 INFO - Cleaning up... 17:00:05 INFO - Return code: 0 17:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00: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')]} 17:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:05 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 17:00:05 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 17:00:05 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 17:00:05 INFO - Using env: {'DISPLAY': ':0', 17:00:05 INFO - 'HOME': '/home/cltbld', 17:00:05 INFO - 'LANG': 'en_US.UTF-8', 17:00:05 INFO - 'LANGUAGE': 'en_US:en', 17:00:05 INFO - 'LOGNAME': 'cltbld', 17:00:05 INFO - 'MAIL': '/var/mail/cltbld', 17:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:05 INFO - 'MOZ_NO_REMOTE': '1', 17:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:05 INFO - 'NO_EM_RESTART': '1', 17:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:05 INFO - 'PWD': '/builds/slave/test', 17:00:05 INFO - 'SHELL': '/bin/bash', 17:00:05 INFO - 'SHLVL': '1', 17:00:05 INFO - 'TERM': 'linux', 17:00:05 INFO - 'TMOUT': '86400', 17:00:05 INFO - 'USER': 'cltbld', 17:00:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:05 INFO - '_': '/tools/buildbot/bin/python'} 17:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:05 INFO - Running setup.py (path:/tmp/pip-HO0CxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:05 INFO - Running setup.py (path:/tmp/pip-hyQXAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:05 INFO - Running setup.py (path:/tmp/pip-2F492B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:05 INFO - Running setup.py (path:/tmp/pip-1Kn5Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:05 INFO - Running setup.py (path:/tmp/pip-J9ec3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:05 INFO - Running setup.py (path:/tmp/pip-n3CM4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:05 INFO - Running setup.py (path:/tmp/pip-mgBgIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:05 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)) 17:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:05 INFO - Running setup.py (path:/tmp/pip-m04UW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:06 INFO - Running setup.py (path:/tmp/pip-sHz2gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:06 INFO - Running setup.py (path:/tmp/pip-bRkSrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:06 INFO - Running setup.py (path:/tmp/pip-YhBF2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:06 INFO - Running setup.py (path:/tmp/pip-jDlmTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:06 INFO - Running setup.py (path:/tmp/pip-unKkbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:06 INFO - Running setup.py (path:/tmp/pip-yLBDe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:06 INFO - Running setup.py (path:/tmp/pip-IMYUT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:06 INFO - Running setup.py (path:/tmp/pip-TaRBq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:06 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)) 17:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:06 INFO - Running setup.py (path:/tmp/pip-lO3bXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 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)) 17:00:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:06 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 17:00:06 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 17:00:06 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 17:00:06 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 17:00:07 INFO - Downloading blessings-1.6.tar.gz 17:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:07 INFO - Installing collected packages: blessings 17:00:07 INFO - Running setup.py install for blessings 17:00:07 INFO - Successfully installed blessings 17:00:07 INFO - Cleaning up... 17:00:08 INFO - Return code: 0 17:00:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:08 INFO - Reading from file tmpfile_stdout 17:00:08 INFO - Current package versions: 17:00:08 INFO - argparse == 1.2.1 17:00:08 INFO - blessings == 1.6 17:00:08 INFO - blobuploader == 1.2.4 17:00:08 INFO - docopt == 0.6.1 17:00:08 INFO - functools32 == 3.2.3-2 17:00:08 INFO - jsonschema == 2.5.1 17:00:08 INFO - manifestparser == 1.1 17:00:08 INFO - mozInstall == 1.13 17:00:08 INFO - mozcrash == 1.0 17:00:08 INFO - mozdebug == 0.1 17:00:08 INFO - mozdevice == 0.51 17:00:08 INFO - mozfile == 1.2 17:00:08 INFO - mozhttpd == 0.7 17:00:08 INFO - mozinfo == 0.10 17:00:08 INFO - mozleak == 0.1 17:00:08 INFO - mozlog == 3.5 17:00:08 INFO - moznetwork == 0.27 17:00:08 INFO - mozprocess == 0.25 17:00:08 INFO - mozprofile == 0.28 17:00:08 INFO - mozrunner == 6.13 17:00:08 INFO - mozscreenshot == 0.1 17:00:08 INFO - mozsystemmonitor == 0.3 17:00:08 INFO - moztest == 0.8 17:00:08 INFO - mozversion == 1.4 17:00:08 INFO - psutil == 3.1.1 17:00:08 INFO - requests == 1.2.3 17:00:08 INFO - wsgiref == 0.1.2 17:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00: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')]} 17:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:08 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 17:00:08 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 17:00:08 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 17:00:08 INFO - Using env: {'DISPLAY': ':0', 17:00:08 INFO - 'HOME': '/home/cltbld', 17:00:08 INFO - 'LANG': 'en_US.UTF-8', 17:00:08 INFO - 'LANGUAGE': 'en_US:en', 17:00:08 INFO - 'LOGNAME': 'cltbld', 17:00:08 INFO - 'MAIL': '/var/mail/cltbld', 17:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:08 INFO - 'MOZ_NO_REMOTE': '1', 17:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:08 INFO - 'NO_EM_RESTART': '1', 17:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:08 INFO - 'PWD': '/builds/slave/test', 17:00:08 INFO - 'SHELL': '/bin/bash', 17:00:08 INFO - 'SHLVL': '1', 17:00:08 INFO - 'TERM': 'linux', 17:00:08 INFO - 'TMOUT': '86400', 17:00:08 INFO - 'USER': 'cltbld', 17:00:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:08 INFO - '_': '/tools/buildbot/bin/python'} 17:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 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)) 17:00:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:00:09 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)) 17:00:09 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)) 17:00:09 INFO - Installing collected packages: simplejson 17:00:09 INFO - Running setup.py install for simplejson 17:00:09 INFO - building 'simplejson._speedups' extension 17:00:09 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 17:00:10 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 17:00:10 INFO - Successfully installed simplejson 17:00:10 INFO - Cleaning up... 17:00:10 INFO - Return code: 0 17:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:10 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 0xf581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', '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 17:00:10 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 17:00:10 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 17:00:10 INFO - Using env: {'DISPLAY': ':0', 17:00:10 INFO - 'HOME': '/home/cltbld', 17:00:10 INFO - 'LANG': 'en_US.UTF-8', 17:00:10 INFO - 'LANGUAGE': 'en_US:en', 17:00:10 INFO - 'LOGNAME': 'cltbld', 17:00:10 INFO - 'MAIL': '/var/mail/cltbld', 17:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:10 INFO - 'MOZ_NO_REMOTE': '1', 17:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:10 INFO - 'NO_EM_RESTART': '1', 17:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:10 INFO - 'PWD': '/builds/slave/test', 17:00:10 INFO - 'SHELL': '/bin/bash', 17:00:10 INFO - 'SHLVL': '1', 17:00:10 INFO - 'TERM': 'linux', 17:00:10 INFO - 'TMOUT': '86400', 17:00:10 INFO - 'USER': 'cltbld', 17:00:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:10 INFO - '_': '/tools/buildbot/bin/python'} 17:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:10 INFO - Cleaning up... 17:00:10 INFO - Return code: 0 17:00:10 INFO - Running post-action listener: _resource_record_post_action 17:00:10 INFO - Running post-action listener: _start_resource_monitoring 17:00:10 INFO - Starting resource monitoring. 17:00:10 INFO - [mozharness: 2017-10-03 00:00:10.987668Z] Finished create-virtualenv step (success) 17:00:10 INFO - [mozharness: 2017-10-03 00:00:10.988713Z] Running install step. 17:00:10 INFO - Running pre-action listener: _resource_record_pre_action 17:00:10 INFO - Running main action method: install 17:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:11 INFO - Reading from file tmpfile_stdout 17:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:11 INFO - Reading from file tmpfile_stdout 17:00:11 INFO - Output received: 17:00:11 INFO - Usage: mozinstall [options] installer 17:00:11 INFO - Options: 17:00:11 INFO - -h, --help show this help message and exit 17:00:11 INFO - -d DEST, --destination=DEST 17:00:11 INFO - Directory to install application into. [default: 17:00:11 INFO - "/builds/slave/test"] 17:00:11 INFO - --app=APP Application being installed. [default: firefox] 17:00:11 INFO - mkdir: /builds/slave/test/build/application 17:00:11 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'] 17:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:00:28 INFO - Reading from file tmpfile_stdout 17:00:28 INFO - Output received: 17:00:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:28 INFO - Running post-action listener: _resource_record_post_action 17:00:28 INFO - [mozharness: 2017-10-03 00:00:28.969541Z] Finished install step (success) 17:00:28 INFO - [mozharness: 2017-10-03 00:00:28.969794Z] Running setup-mitmproxy step. 17:00:28 INFO - Running pre-action listener: _resource_record_pre_action 17:00:28 INFO - Running main action method: setup_mitmproxy 17:00:28 INFO - Skipping: mitmproxy is not required 17:00:28 INFO - Running post-action listener: _resource_record_post_action 17:00:28 INFO - [mozharness: 2017-10-03 00:00:28.970949Z] Finished setup-mitmproxy step (success) 17:00:28 INFO - [mozharness: 2017-10-03 00:00:28.971171Z] Running run-tests step. 17:00:28 INFO - Running pre-action listener: _resource_record_pre_action 17:00:28 INFO - Running pre-action listener: _set_gcov_prefix 17:00:28 INFO - Running main action method: run_tests 17:00:28 WARNING - Try message not found. 17:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:28 INFO - Python 2.7.3 17:00:28 INFO - Return code: 0 17:00:28 INFO - grabbing minidump binary from tooltool 17:00:28 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')]} 17:00:28 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 0x12c2d60>, '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 0x12c3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c3ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:28 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 17:00:28 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 17:00:28 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 17:00:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:29 INFO - Return code: 0 17:00:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:29 INFO - ENV: RUST_BACKTRACE is now full 17:00:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:29 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/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 17:00:29 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/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 17:00:29 INFO - Using env: {'DISPLAY': ':0', 17:00:29 INFO - 'HOME': '/home/cltbld', 17:00:29 INFO - 'LANG': 'en_US.UTF-8', 17:00:29 INFO - 'LANGUAGE': 'en_US:en', 17:00:29 INFO - 'LOGNAME': 'cltbld', 17:00:29 INFO - 'MAIL': '/var/mail/cltbld', 17:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:29 INFO - 'MOZ_NO_REMOTE': '1', 17:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:29 INFO - 'NO_EM_RESTART': '1', 17:00:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:29 INFO - 'PWD': '/builds/slave/test', 17:00:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:29 INFO - 'RUST_BACKTRACE': 'full', 17:00:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:00:29 INFO - 'SHELL': '/bin/bash', 17:00:29 INFO - 'SHLVL': '1', 17:00:29 INFO - 'TERM': 'linux', 17:00:29 INFO - 'TMOUT': '86400', 17:00:29 INFO - 'USER': 'cltbld', 17:00:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:29 INFO - '_': '/tools/buildbot/bin/python'} 17:00:29 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/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 17:00:29 INFO - mozversion application_buildid: 20171002223356 17:00:29 INFO - mozversion application_changeset: 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad 17:00:29 INFO - mozversion application_display_name: Nightly 17:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:29 INFO - mozversion application_name: Firefox 17:00:29 INFO - mozversion application_remotingname: firefox 17:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:29 INFO - mozversion application_vendor: Mozilla 17:00:29 INFO - mozversion application_version: 58.0a1 17:00:29 INFO - mozversion platform_buildid: 20171002223356 17:00:29 INFO - mozversion platform_changeset: 8f66e0613bd3b1fabb003f970bfe54fd0804e4ad 17:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:29 INFO - mozversion platform_version: 58.0a1 17:00:29 INFO - using testdate: 1506988829 17:00:29 INFO - actual date: 1506988829 17:00:29 INFO - starting webserver on 'localhost:50618' 17:00:29 INFO - SUITE-START | Running 2 tests 17:00:29 INFO - TEST-START | dromaeo_css 17:00:29 INFO - Initialising browser for dromaeo_css test... 17:00:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50618/getInfo.html -profile /tmp/tmp7TetwX/profile 17:00:29 INFO - TEST-INFO | started process 3811 (/builds/slave/test/build/application/firefox/firefox http://localhost:50618/getInfo.html) 17:00:35 INFO - TEST-INFO | 3811: exit 0 17:00:36 INFO - Browser initialized. 17:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:36 INFO - Using env: {'DISPLAY': ':0', 17:00:36 INFO - 'HOME': '/home/cltbld', 17:00:36 INFO - 'JSGC_DISABLE_POISONING': '1', 17:00:36 INFO - 'LANG': 'en_US.UTF-8', 17:00:36 INFO - 'LANGUAGE': 'en_US:en', 17:00:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:00:36 INFO - 'LOGNAME': 'cltbld', 17:00:36 INFO - 'MAIL': '/var/mail/cltbld', 17:00:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:36 INFO - 'MOZ_CRASHREPORTER': '1', 17:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:00:36 INFO - 'MOZ_NO_REMOTE': '1', 17:00:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:36 INFO - 'NO_EM_RESTART': '1', 17:00:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:36 INFO - 'PWD': '/builds/slave/test', 17:00:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:36 INFO - 'RUST_BACKTRACE': 'full', 17:00:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:00:36 INFO - 'SHELL': '/bin/bash', 17:00:36 INFO - 'SHLVL': '1', 17:00:36 INFO - 'STYLO_FORCE_DISABLED': '1', 17:00:36 INFO - 'TERM': 'linux', 17:00:36 INFO - 'TMOUT': '86400', 17:00:36 INFO - 'USER': 'cltbld', 17:00:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:36 INFO - '_': '/tools/buildbot/bin/python'} 17:00:36 INFO - TEST-INFO | started process 4052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TetwX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:36 INFO - PID 4052 | 17:00:36 INFO - PID 4052 | (/builds/slave/test/build/application/firefox/firefox:4101): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:00:36 INFO - PID 4052 | 17:00:47 INFO - PID 4052 | RSS: Main: 141070336 17:00:47 INFO - PID 4052 | 17:03:43 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50618/tests/dromaeo/cssquery-ext.html) 17:03:45 INFO - PID 4052 | RSS: Main: 142782464 17:03:45 INFO - PID 4052 | 17:06:46 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-ext.html (next: http://localhost:50618/tests/dromaeo/cssquery-jquery.html) 17:06:47 INFO - PID 4052 | RSS: Main: 143867904 17:06:47 INFO - PID 4052 | 17:09:49 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50618/tests/dromaeo/cssquery-mootools.html) 17:09:49 INFO - PID 4052 | RSS: Main: 144887808 17:09:49 INFO - PID 4052 | 17:12:51 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50618/tests/dromaeo/cssquery-prototype.html) 17:12:51 INFO - PID 4052 | RSS: Main: 144437248 17:12:51 INFO - PID 4052 | 17:15:54 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50618/tests/dromaeo/cssquery-yui.html) 17:15:55 INFO - PID 4052 | RSS: Main: 148205568 17:15:55 INFO - PID 4052 | 17:18:56 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:50618/tests/dromaeo/cssquery-yui.html (next: http://localhost:50618/tests/dromaeo/cssquery-dojo.html) 17:18:57 INFO - PID 4052 | RSS: Main: 148541440 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | __start_tp_report 17:18:57 INFO - PID 4052 | _x_x_mozilla_page_load 17:18:57 INFO - PID 4052 | _x_x_mozilla_page_load_details 17:18:57 INFO - PID 4052 | |i|pagename|runs| 17:18:57 INFO - PID 4052 | |0;dojo.html;3914.138889444322;3917.764934103954;3935.488386509754;3948.6841052715786;3948.960510394895;6201.627902325852;6358.809235722936;6424.967875160623;6473.838154046145;6521.021846722994;6456.451201647866;6480.12518310028;6498.0902673625615;6505.544611877171;6520.543561950665;5713.942860571383;5766.769329226826;5777.45114214149;5812.796552120677;5847.386024467433;5766.135079738031;5796;5810.041343178392;5816.709164541777;5871.970640146793;73.6771517162406;5717.085266357404;5737.110747834093;5753.597248192628;5885.058390657496;5739;5806.390329015435;5820.185174075633;5824.417558244184;5832.833433313312;5680.0627896397045;5686.516646085088;5719.628224165457;5726.68503232322;5804.448577385142;6310.684465776739;6330.746770129189;6402.519811014193;6417.39034791694;6487.545871788977;6943.6875340609795;6981.197162326347;7020.613866237355;7029;7029.89455158173;6942.687579058955;6986.650667466606;7018.964905175441;7022.332878376546;7060.611666358348;6404.455621272197;6464.515161362917;6481.189851268591;6501.187351581052;6564.540482166298;7227.241139680363;7286.96356518214;7294.817629559304;7296.96351518239;7300.050993370828;6911.3779759821855;6915.654217289115;6955.89566156508;6977.232504424509;7023.192332881784;6887.690053947585;7025.086738723933;7035.085438892911;7108.71565137399;7116.217216106224;6908.585484870924;6931;6992.6853291602;6993.545419547713;7003.089598352181;6993.195782484978;6996.510244282851;7011.614361210182;7021.964890175618;7032.507724459341;5130.974345128325;5147.124988751922;5151.25306830515;5156.845294641167;5161.870953226125;4574.771261436915;4628.95371046292;4683.96952670412;4684.859454216379;4687.414073240845;6356.459700925473;6381.649009304533;6426.2931077581425;6465.450436712932;6465.450436712932;6993.811052121152;7041.753538626123;7055.6119413431725;7071.222165561784;7073.151221853411;6354.872902541923;6392.808215753535;6404.775832845828;6473;6481.578697384655;5620.241267428926;5628.746706398222;5694.6583205007;5705.1727499512335;5713.542916566747;7095.432365410755;7245.420366370678;7245.492815502969;7245.782626521107;7255;6954.79135625932;6955.061066756024;6980.987756775341;6987.825304367431;7036.718531258693;7172;7221.061262036112;7249.420046396381;7251.274872512707;7314.890276645748;6856.382925536725;6918.8616227676175;6934.895976560255;6947.4789390796905;7006.299370063157;6940.757073502403;6955.956606509064;7033.437325014089;7055.894161587477;7059.894101588583;6829.453643708392;6850.6574671267235;6851.9657401712675;6866.4506839453725;6881.174259088742;6760.763373281911;6766.729330826712;6835.624040677611;6837.418819400208;6841.350071743176;6529.412352888263;6656.36764507371;6658.83352916181;6737.562058466184;6765.086713293643;6825.488088393291;6836.008778726958;6848.794536163923;6850.280720524273;6861.691223895036;6629.867402652017;6632.104665870046;6647.135872336758;6649.900251496135;6677.866442671217 17:18:57 INFO - PID 4052 | |1;ext.html;945.9668911588096;952.4190243951193;978.0415193110751;1003.2074661017797;1003.5634498992939;42787.572124278784;43596.564034359646;43617.12765744687;43625.563744362546;43729.344059839124;39876.601233987654;40016.199676006465;40160.79919600405;40169.39745903814;40219.19561608766;7426.925730742704;7528.247175282483;7535.20880307568;7537.907003484492;7548.20743821899;7361.447891408166;7442.851142977137;7494.5128566643;7508.587027713474;7514.173440921494;8227.300679442254;8397.622107005169;8403;8405.075441701438;8418.579071046423;8284.58577071147;8350.039745429262;8380.664773409057;8405.075441701409;8429.494230346138;8013.879791803128;8200.507969521788;8207.95896020522;8210;8272;39773.20453590912;40060.39909401332;40132.59867401318;40157.196856063005;40221.39667904984;3659.908502287464;3737.5141231639714;3738.065483629093;3740.6446387593137;3741.5136032315627;30633.540496892565;30647.693523064707;30735;30764.2308942276;30765.69234307673;5515.200295957104;5541.307336582927;5555.749991250363;5557.527610153102;5645.971770141164;220758;221054;221329;222019;222526;50226.49773502292;50263.492095237205;50270.748646256536;50350;50456.495435045916;52590;52680.20979685308;52744.73627631837;52806.471935280926;52809.73595132;17015.489535313962;17239.22423490946;17279.74080388795;17289.740653890203;17312.740308895376;14104.435822566982;14121.505747298796;14171.85828141726;14179.716405671828;14186.85813141876;15213.771793423108;15292.770608440882;15295.847041529441;15326.080435173924;15342.15894092716;6130.63216207029;6200.3799620037635;6243.219597550306;6321.683915804191;6335.461485773669;1091.901728844408;1095.8137116690182;1101.4162493878257;1114.147677027075;1125.836753670713;25231.747682523306;25659.743402565735;25746.227613171635;25758.613620795328;26009.73990260111;1194.6714653470365;1201.1171788735273;1214.2107630040368;1219.1222319929814;1224.3143839449758;13551.983601229947;13587.184768913898;13830.930845345709;13847.169169849842;13847.861521384859;260193;260698;260846;261059;261674;56817.43182568204;57019.144712829344;60044;61087.38912610906;61358.38641613616;1519.7112548615728;1538.3231378193782;1538.569200623827;1552.9922350388401;1553.2156261088305;30472;30792.84603576968;30826;30832.383352332377;30897.691023089483;40394;40501.1899762009;40543;40577.391339129346;40608.59391406048;227311;227839;227980;228189;228815;33693.83153084219;33862.32275354528;34188.658113419544;34217.828910855285;34314.14214644654;44175.33736993883;44183.77908110568;44208;44316.55683443253;44337.11325773531;33490.49764253587;33491;33857.49213761746;33923.83038084794;34249.82875085609;32515;32828;32977.505337420436;33397.49903751494;33654.326913461104;39272.80363598164;39455.2108957825;39487.2102557953;39508.40737388999;39596;32177.678223217466;32359.400267523844;32557;32798.34403311968;33028.83485582557;24785.62821557642;25288.74711252864;25315.240542783748;25850;26011.73988260093 17:18:57 INFO - PID 4052 | |2;jquery.html;634.2260370029447;636.2374964344593;640.8599423518682;644.7580188702461;648.8248074264268;23150;23707.407314817137;23855.045798168052;24006.039758409665;24022.75977240227;25520.872395637994;25706;25757.48485030303;25880.74119258807;25903.740962590367;6267.2165979252595;6351.333110023439;6462.935370646281;6508.31662675417;6516.869662606745;6537.803865884031;6632.2704502504685;6633.568818026837;6636.867262654744;6640.701168447432;6554.311797261291;6570.080188773575;6597.901031484532;6793.626350550718;6834.897476537856;6696.564723292995;6724.932750672479;6727.495437842182;6732.124823772878;6737.93262067378;5960.4635582797755;6143.078538219258;6348.523860710419;6359.20509936258;6367.522435817286;30334.241643959078;31029;31039.844800776078;31042.379152417052;31089;2217.534317793249;2246.663000549914;2248.8875556222124;2252.842301038928;2261.638137897945;20298.797012029838;20327.390178294674;20672.689909651366;20711.8964405177;21073.367798966057;2567.8844451999703;2590.119359417788;2608.2696844883462;2678.383971686523;2682.1149020823277;123507;129423.35288323593;154517;158935.2053239738;159254;16057.919710401373;16154.345978907288;16412.589685257964;16887.408940687015;17151.399701010403;26449.206523804318;26538.275012124537;26549;26648.60027099595;26674.733252667615;10303.9484802577;10471.94764026175;10572;10596.629117980834;10677.9466102669;9458.871753855328;9530.571124299424;9546.570404331822;9554.423520119102;9634.518274086267;10003.24975626831;10021;10072.496375181358;10189.439580822978;10248.489120165606;2962.6592941811537;2962.7037296270632;3016.155476466593;3029.621297337833;3047.4362242985117;1042.020500729312;1045.17953406577;1048.8269435543202;1050.695298363466;1051.4742628685658;20493;20535;20772.06525706347;20781.480462988246;20788.27241046556;1095.9178061645248;1105.8617672790901;1111.155521803419;1118.8881111888745;1122.6968718445974;11493.367864767351;11709.531618735326;11750.77445787952;11752.823707644393;11797.469113889896;544521;564575;569701;575799;577708;128617;131814.34092829475;132743.3362833199;134089;134910;1128.4301427779083;1174.2895548193392;1222.5965431407615;1223.9877601224052;1283.5635883799553;21567.784322156578;21791.891040544695;21951.780482194972;21989.450263742896;22030.449238768517;63025.36974630378;64043;64512.67743661252;64995;66504;78413.60793195998;78616;78621;81110.59444702975;82627.17372826194;15732.370705171665;16014.439494617633;16040.197990100214;16062.518124456285;16090.919545402197;23905.402364941016;24018.879905601058;24043.278701638978;24057.759422406252;24443.877780610983;19131.13909874031;19171.137298821865;19736.210551577777;19919.502012449804;19919.502012449804;17387.56531086733;17629.20668569892;17800.13948390933;18082.457526274233;18302.63394732071;19091;20031.59936801285;20235.79764202339;20241.392758217276;20359.287424940056;15755.606109847346;15806.446774363301;15809.762853557437;15827.129507876716;15848.683026339639;19656.90171549133;19725.24727745041;19873.801261987195;19918.70121948143;20022.49943751418 17:18:57 INFO - PID 4052 | |3;mootools.html;1450.4415799917033;1504.6990601879627;1513.1299502785887;1515.9545213643592;1542.4909779772677;16894.91552542237;17552.912235438806;17559.209835557398;17573.29706811726;17575.648487030267;16943.32226710933;17072.231749571267;17080.145992700378;17111.74332385015;17146.571335716613;2836.8297902125837;2877.5539791332376;2921.0652591170833;2924.1958461423174;2927.443785680714;2790.8185967912123;2875;2884.0915111739737;2888.4078763853463;2890.739833414992;2698.7031426543163;2878.568214767781;2948.808327458719;2964.9258768530744;2972.2420782700488;2841;2844.1183233197776;2863.1410576827075;2872.669642991051;2874.7843911706705;2747.2719729271757;2770.9722902770914;2777.916662500128;2792.860356982163;2821.562657788046;16326.510204693877;16737;16784.748228776578;16918.915405422893;16951.406700765536;8161.63272652732;8417.74746757592;8434.40959132861;8439.156084391512;8443.408961372645;5433.538149257279;5552.694601796899;5630.634008789416;5646.971765141189;5778.451047150514;2086.7078608994752;2123.5115923337567;2127.914883404662;2157.7194964654495;2195.506011147479;30506.08481745529;31305.530417043763;31515.369692606248;31579;31790.04629861108;7306.5981371024045;7332.816679582947;7358.300961408658;7464.178940316561;7483.925160748432;20442.591148176954;20478.692819607717;20567;20605.89697051535;20684.79315206859;8186.877196842052;8339.457935234312;8362.247397734232;8367.03779065403;8369.623366948503;7619.809504762315;7673.923260767432;7750.379969602418;7888.802779930433;7892.368610511146;5903.881922361528;5932.377100404482;6021.066734656135;6093;6095.4818840398175;1701.8723595730369;1723.9482815515555;1742.4946765438135;1756.1307152959366;1776.7246076858107;984.7390441532999;990.4997976022063;1006.2302338710892;1018.4856647393019;1023.9283250172416;8665.263452606472;8668.696595619123;8676.696315628922;8891.333150013776;9003.279737620975;798.7404093669464;798.8681867491915;801.9679212831421;803.445622520459;813.3168138763467;5361.892762144813;5467.5625949923915;5490.203920431595;5514.751836167382;5536.335639723178;23990.640140397907;24994.875025624755;25038.624420633703;25043;25128.120515782226;23788;24596.262112136665;24597;25954.480910382063;26021.089261875743;10982.670519884416;11225.158113141548;12632.11575189728;12745.362731863555;13179.472821087049;9955.303128780915;10067;10107.292489525662;10323.63867264642;10334.173266138841;20939.685904711136;21687.132514699235;21753.782462175808;21768.56462870702;22093.77906220917;22180.223692170697;22185.223517176822;22199.112035519043;22279;22629.547409052055;12974.481020759442;13179.275139867399;13188.934055329662;13213.537526186537;13219.735605288033;15191.088534687955;15412.075275483507;15586.454474093352;15631.218439078228;15661.21693915277;12580;12643.114981951176;12770.61688149357;13086.214827110403;13197.076204665582;12069.27584344942;12132.514699411924;12206.633800985985;12279.263244205376;12357.629271121881;10961.177911656498;11045.558177672803;11097.11223102166;11099.056580190774;11099.611513596985;8463.74608761738;8560.229579337889;8641.95679021626;8643.611037503202;8832.558372081241;8634.179752923463;8637.611307491052;8686.956565217386;8811.911880881109;8845.203931646183 17:18:57 INFO - PID 4052 | |4;prototype.html;541.5775694957932;565.2002416580539;573.166043406843;579;583.6848102024906;6231.781887633933;6280.591761535497;6330.65181415022;6360.4911607071435;6368.904466433001;6239.188905442297;6249.9062514062325;6293.559450838432;6297.149884765556;6301.2753533343675;5175.327207463025;5192.4547922468255;5215.973920130413;5223.529882310591;5236.633435659505;4927.507249275061;5068.34111565496;5151.948480515203;5154.716490593016;5189.740512974355;5030.421501527317;5058.747062646871;5067.163917953533;5082.415522214956;5105.361829771278;5034.798608055673;5050.343455350818;5051.2423136529815;5075.238714192864;5099.847004589849;4562.178807814592;4599.747013914233;4627.329037289608;4630.490646028934;4657.6273898088075;6273.6235825850135;6284.811455656338;6286.654234017127;6315.810525684236;6320.27316858558;5940.910886336708;5949.631584735492;6005.939940600581;6013.526685961923;6018.127371531147;6603.306652801435;6634.601923884534;6667.299933507009;6667.466602671775;6702.262751097375;5138.486151384832;5141.691498510101;5175.4991052594705;5183.222516622499;5195.558377537914;6775.491838112112;6909.7581584644795;7017.47368947331;7039.542429742101;7040.471964602624;5281.709505977208;5284.841454756363;5313.521783039468;5314.3091398117995;5336.7865285388925;5347.144456886957;5349.679019258779;5403.0814761489855;5411.2965314508865;5420.891582168413;5836.358000619928;5852.209951656557;5893.469587737124;5964.910526342108;6009.519238460913;6735.8989615155815;6748.460123190133;6807.863842723118;6821.69302381394;6822.761203357859;1852.9258829646662;1859.414284500405;1863.4782260966952;1882.2282864025683;1889.990550047241;1275.101053757099;1328.136711137768;1332.8733770291806;1338.772408690525;1349.3657980749033;6165.753369865245;6192.721327540272;6201.472874805692;6264.248290205204;6296.338884417162;6674.966625166843;6677.933220667828;6727.562708423937;6746.414592570742;6824.112865327475;6170.642458659087;6207.379262073757;6235.844103897439;6257.530685198628;6300.810975670737;3559.430491121408;3576.964230357715;3613.223157021253;3619.5113659656135;3629.491871138043;7081.221065682771;7085.964570177116;7097.822554436078;7126.536775109601;7138.821529461805;6945.583265004116;6954.4436445084275;7013.368796808311;7029;7058.752943646948;6914.723411063501;6930.584164950119;6994.93005069953;7032.05067315916;7065.304326961595;6717.832054198684;6721.764738234334;6761.966190169018;6784.3894049535775;6809.944458608924;6712.228093769279;6761.830954226184;6767.255601883888;6768.830779230559;6779.288174741581;7047.859042819013;7063.894041589278;7074;7076.964615176891;7118.181409137808;5328.920066199088;5332.280142180756;5344.4922732340365;5348.786048558014;5351.892962140658;6665.66671666405;6825.726970921306;6835.487338449736;6911.965440172767;6913.412359949461;6502.934970650233;6540.313267106885;6562.5406221564035;6628.204615446178;6637.402633762985;6485.254195767548;6517.250516190698;6525.738970441129;6559.573627714183;6616.643588064339;6319.724899036251;6409.487241020801;6416.967915160394;6457.7094030767785;6494.253160886558;6645.401913827779;6654.567453115532;6664.666766661744;6721.529492935448;6723.226828914738;6436.517261205335;6452.451541619015;6466.935330646634;6492.545521813617;6494.188226471691 17:18:57 INFO - PID 4052 | |5;yui.html;968.2689569375125;978.0854900667877;996.9052939970704;1005.1857995024036;1008.4957521239382;18595.814041859594;19391;19417.126229319678;19418.708719369202;24466.75533244667;23479.530409391802;23571.646425303636;23574.764252357472;23609.291721248348;23654.76345236547;1089.1559041742653;1097.2757979733337;1107.9224454288203;1108.279618248137;1109.7447587054942;1106.6403418888854;1108.2242430298784;1122.354646078504;1127.10958342909;1127.9154063445233;1166.8716441191461;1171.1509155862018;1171.8652354979158;1171.8945294923456;1175.8001139806254;1163.4241050679882;1168.4449886304023;1170.8594968603736;1172.7537217184358;1172.7947609168405;844.1980118887082;851.6337974670889;855.0637052427581;855.085058986878;856.7900864288227;20713.5857282855;20727;21015.8949205253;21106.366808995754;21600.351989440343;22736.88631556848;23014.309570712907;23478.530429391318;23680.28959131229;23683.644745328835;17296.654066918592;17650.823491765048;17676;17730.468085957444;17809.19858606366;3973.6225058619384;4017.5982401759884;4028.7179897407195;4031.596840315974;4033.878983630496;157168.2141589285;159842;159945;163132;163579.1821040899;17582.472525824247;17624.118794060247;17950;17959.281628734967;17968.730469042974;34676.30647387038;35110.473342899364;35698;35729.82135089308;35859.82070089633;9055.773605659911;9079.863802042975;9198.77003074915;9204.263658907272;9217.354785164975;4098.569650186747;4253.617174454252;4805.543473370024;4933.531314525115;4955.925661115086;6009.669468179205;6090.23872015998;6137.9079313810325;6140.109684095781;6152.815415537541;1135.4606561883204;1170.4849866058908;1171.9589814356627;1181.1908842442954;1185.1763024697925;706.4630880530833;725.6081715873369;732.168988198388;748.569572495817;749.9700011999568;13159;13217;13392.933035334761;14064.015518913578;14134.36395362211;722.4184531452231;722.458156382713;723.6237156678498;727.1637616740685;752.766642340876;5966.612170208922;6010.66941318223;6020.127081573235;6033.5474839387225;6082.482988945901;148405;148715;152035.23982380237;152177.23911380593;152405;126245;126577;129832;130036;131472;113274.43362783133;113453;113628;114910;117586.41206794082;10939.343639381663;11056.944715276371;11166.609168679057;11337.659870203906;11374;54151.458485414645;54233.915321694134;54666.72666636641;55206;56550.15174772299;70036.64981675263;70429;70608;70703;71983.28016719766;17966.191521381832;17975.101244937963;18187.909060454615;18334.908325458287;18376.724349135042;17035.148242588068;17412.82587174163;17563.209655565275;17728.91135544314;21073.89463052675;20773.169073236902;20868.895655521625;20943.057562409424;21131.788682113598;21224.151033959086;19182.80817191866;19409.32067377635;19508.21967121299;19559.511012224808;19587.118579663664;18938.43184704406;18993.385562227366;19030.42908712741;19047.52381190481;19193.90403047976;13798.93100534491;14062.718745625234;14127.858721413066;14271.21508317011;14282.642933926734;15016;15157.393704251706;15353.539393818204;15392.692146157238;15470.381184752483 17:18:57 INFO - PID 4052 | __end_tp_report 17:18:57 INFO - PID 4052 | __start_cc_report 17:18:57 INFO - PID 4052 | _x_x_mozilla_cycle_collect,253 17:18:57 INFO - PID 4052 | __end_cc_report 17:18:57 INFO - PID 4052 | __startTimestamp1506989937058__endTimestamp 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | ------- Summary: start ------- 17:18:57 INFO - PID 4052 | Number of tests: 6 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#0] dojo.html Cycles:165 Average:6402.40 Median:6737.56 stddev:917.10 (13.6%) stddev-sans-first:898.90 17:18:57 INFO - PID 4052 | Values: 3914.1 3917.8 3935.5 3948.7 3949.0 6201.6 6358.8 6425.0 6473.8 6521.0 6456.5 6480.1 6498.1 6505.5 6520.5 5713.9 5766.8 5777.5 5812.8 5847.4 5766.1 5796.0 5810.0 5816.7 5872.0 73.7 5717.1 5737.1 5753.6 5885.1 5739.0 5806.4 5820.2 5824.4 5832.8 5680.1 5686.5 5719.6 5726.7 5804.4 6310.7 6330.7 6402.5 6417.4 6487.5 6943.7 6981.2 7020.6 7029.0 7029.9 6942.7 6986.7 7019.0 7022.3 7060.6 6404.5 6464.5 6481.2 6501.2 6564.5 7227.2 7287.0 7294.8 7297.0 7300.1 6911.4 6915.7 6955.9 6977.2 7023.2 6887.7 7025.1 7035.1 7108.7 7116.2 6908.6 6931.0 6992.7 6993.5 7003.1 6993.2 6996.5 7011.6 7022.0 7032.5 5131.0 5147.1 5151.3 5156.8 5161.9 4574.8 4629.0 4684.0 4684.9 4687.4 6356.5 6381.6 6426.3 6465.5 6465.5 6993.8 7041.8 7055.6 7071.2 7073.2 6354.9 6392.8 6404.8 6473.0 6481.6 5620.2 5628.7 5694.7 5705.2 5713.5 7095.4 7245.4 7245.5 7245.8 7255.0 6954.8 6955.1 6981.0 6987.8 7036.7 7172.0 7221.1 7249.4 7251.3 7314.9 6856.4 6918.9 6934.9 6947.5 7006.3 6940.8 6956.0 7033.4 7055.9 7059.9 6829.5 6850.7 6852.0 6866.5 6881.2 6760.8 6766.7 6835.6 6837.4 6841.4 6529.4 6656.4 6658.8 6737.6 6765.1 6825.5 6836.0 6848.8 6850.3 6861.7 6629.9 6632.1 6647.1 6649.9 6677.9 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#1] ext.html Cycles:180 Average:41317.25 Median:34281.99 stddev:61580.00 (179.6%) stddev-sans-first:61678.14 17:18:57 INFO - PID 4052 | Values: 946.0 952.4 978.0 1003.2 1003.6 42787.6 43596.6 43617.1 43625.6 43729.3 39876.6 40016.2 40160.8 40169.4 40219.2 7426.9 7528.2 7535.2 7537.9 7548.2 7361.4 7442.9 7494.5 7508.6 7514.2 8227.3 8397.6 8403.0 8405.1 8418.6 8284.6 8350.0 8380.7 8405.1 8429.5 8013.9 8200.5 8208.0 8210.0 8272.0 39773.2 40060.4 40132.6 40157.2 40221.4 3659.9 3737.5 3738.1 3740.6 3741.5 30633.5 30647.7 30735.0 30764.2 30765.7 5515.2 5541.3 5555.7 5557.5 5646.0 220758.0 221054.0 221329.0 222019.0 222526.0 50226.5 50263.5 50270.7 50350.0 50456.5 52590.0 52680.2 52744.7 52806.5 52809.7 17015.5 17239.2 17279.7 17289.7 17312.7 14104.4 14121.5 14171.9 14179.7 14186.9 15213.8 15292.8 15295.8 15326.1 15342.2 6130.6 6200.4 6243.2 6321.7 6335.5 1091.9 1095.8 1101.4 1114.1 1125.8 25231.7 25659.7 25746.2 25758.6 26009.7 1194.7 1201.1 1214.2 1219.1 1224.3 13552.0 13587.2 13830.9 13847.2 13847.9 260193.0 260698.0 260846.0 261059.0 261674.0 56817.4 57019.1 60044.0 61087.4 61358.4 1519.7 1538.3 1538.6 1553.0 1553.2 30472.0 30792.8 30826.0 30832.4 30897.7 40394.0 40501.2 40543.0 40577.4 40608.6 227311.0 227839.0 227980.0 228189.0 228815.0 33693.8 33862.3 34188.7 34217.8 34314.1 44175.3 44183.8 44208.0 44316.6 44337.1 33490.5 33491.0 33857.5 33923.8 34249.8 32515.0 32828.0 32977.5 33397.5 33654.3 39272.8 39455.2 39487.2 39508.4 39596.0 32177.7 32359.4 32557.0 32798.3 33028.8 24785.6 25288.7 25315.2 25850.0 26011.7 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#2] jquery.html Cycles:180 Average:38743.08 Median:2232.10 stddev:95153.63 (4263.0%) stddev-sans-first:95377.54 17:18:57 INFO - PID 4052 | Values: 634.2 636.2 640.9 644.8 648.8 23150.0 23707.4 23855.0 24006.0 24022.8 25520.9 25706.0 25757.5 25880.7 25903.7 6267.2 6351.3 6462.9 6508.3 6516.9 6537.8 6632.3 6633.6 6636.9 6640.7 6554.3 6570.1 6597.9 6793.6 6834.9 6696.6 6724.9 6727.5 6732.1 6737.9 5960.5 6143.1 6348.5 6359.2 6367.5 30334.2 31029.0 31039.8 31042.4 31089.0 2217.5 2246.7 2248.9 2252.8 2261.6 20298.8 20327.4 20672.7 20711.9 21073.4 2567.9 2590.1 2608.3 2678.4 2682.1 123507.0 129423.4 154517.0 158935.2 159254.0 16057.9 16154.3 16412.6 16887.4 17151.4 26449.2 26538.3 26549.0 26648.6 26674.7 10303.9 10471.9 10572.0 10596.6 10677.9 9458.9 9530.6 9546.6 9554.4 9634.5 10003.2 10021.0 10072.5 10189.4 10248.5 2962.7 2962.7 3016.2 3029.6 3047.4 1042.0 1045.2 1048.8 1050.7 1051.5 20493.0 20535.0 20772.1 20781.5 20788.3 1095.9 1105.9 1111.2 1118.9 1122.7 11493.4 11709.5 11750.8 11752.8 11797.5 544521.0 564575.0 569701.0 575799.0 577708.0 128617.0 131814.3 132743.3 134089.0 134910.0 1128.4 1174.3 1222.6 1224.0 1283.6 21567.8 21791.9 21951.8 21989.5 22030.4 63025.4 64043.0 64512.7 64995.0 66504.0 78413.6 78616.0 78621.0 81110.6 82627.2 15732.4 16014.4 16040.2 16062.5 16090.9 23905.4 24018.9 24043.3 24057.8 24443.9 19131.1 19171.1 19736.2 19919.5 19919.5 17387.6 17629.2 17800.1 18082.5 18302.6 19091.0 20031.6 20235.8 20241.4 20359.3 15755.6 15806.4 15809.8 15827.1 15848.7 19656.9 19725.2 19873.8 19918.7 20022.5 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#3] mootools.html Cycles:180 Average:10571.48 Median:25987.79 stddev:7838.32 (30.2%) stddev-sans-first:7830.35 17:18:57 INFO - PID 4052 | Values: 1450.4 1504.7 1513.1 1516.0 1542.5 16894.9 17552.9 17559.2 17573.3 17575.6 16943.3 17072.2 17080.1 17111.7 17146.6 2836.8 2877.6 2921.1 2924.2 2927.4 2790.8 2875.0 2884.1 2888.4 2890.7 2698.7 2878.6 2948.8 2964.9 2972.2 2841.0 2844.1 2863.1 2872.7 2874.8 2747.3 2771.0 2777.9 2792.9 2821.6 16326.5 16737.0 16784.7 16918.9 16951.4 8161.6 8417.7 8434.4 8439.2 8443.4 5433.5 5552.7 5630.6 5647.0 5778.5 2086.7 2123.5 2127.9 2157.7 2195.5 30506.1 31305.5 31515.4 31579.0 31790.0 7306.6 7332.8 7358.3 7464.2 7483.9 20442.6 20478.7 20567.0 20605.9 20684.8 8186.9 8339.5 8362.2 8367.0 8369.6 7619.8 7673.9 7750.4 7888.8 7892.4 5903.9 5932.4 6021.1 6093.0 6095.5 1701.9 1723.9 1742.5 1756.1 1776.7 984.7 990.5 1006.2 1018.5 1023.9 8665.3 8668.7 8676.7 8891.3 9003.3 798.7 798.9 802.0 803.4 813.3 5361.9 5467.6 5490.2 5514.8 5536.3 23990.6 24994.9 25038.6 25043.0 25128.1 23788.0 24596.3 24597.0 25954.5 26021.1 10982.7 11225.2 12632.1 12745.4 13179.5 9955.3 10067.0 10107.3 10323.6 10334.2 20939.7 21687.1 21753.8 21768.6 22093.8 22180.2 22185.2 22199.1 22279.0 22629.5 12974.5 13179.3 13188.9 13213.5 13219.7 15191.1 15412.1 15586.5 15631.2 15661.2 12580.0 12643.1 12770.6 13086.2 13197.1 12069.3 12132.5 12206.6 12279.3 12357.6 10961.2 11045.6 11097.1 11099.1 11099.6 8463.7 8560.2 8642.0 8643.6 8832.6 8634.2 8637.6 8687.0 8811.9 8845.2 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#4] prototype.html Cycles:180 Average:5699.77 Median:6294.95 stddev:1573.59 (25.0%) stddev-sans-first:1529.63 17:18:57 INFO - PID 4052 | Values: 541.6 565.2 573.2 579.0 583.7 6231.8 6280.6 6330.7 6360.5 6368.9 6239.2 6249.9 6293.6 6297.1 6301.3 5175.3 5192.5 5216.0 5223.5 5236.6 4927.5 5068.3 5151.9 5154.7 5189.7 5030.4 5058.7 5067.2 5082.4 5105.4 5034.8 5050.3 5051.2 5075.2 5099.8 4562.2 4599.7 4627.3 4630.5 4657.6 6273.6 6284.8 6286.7 6315.8 6320.3 5940.9 5949.6 6005.9 6013.5 6018.1 6603.3 6634.6 6667.3 6667.5 6702.3 5138.5 5141.7 5175.5 5183.2 5195.6 6775.5 6909.8 7017.5 7039.5 7040.5 5281.7 5284.8 5313.5 5314.3 5336.8 5347.1 5349.7 5403.1 5411.3 5420.9 5836.4 5852.2 5893.5 5964.9 6009.5 6735.9 6748.5 6807.9 6821.7 6822.8 1852.9 1859.4 1863.5 1882.2 1890.0 1275.1 1328.1 1332.9 1338.8 1349.4 6165.8 6192.7 6201.5 6264.2 6296.3 6675.0 6677.9 6727.6 6746.4 6824.1 6170.6 6207.4 6235.8 6257.5 6300.8 3559.4 3577.0 3613.2 3619.5 3629.5 7081.2 7086.0 7097.8 7126.5 7138.8 6945.6 6954.4 7013.4 7029.0 7058.8 6914.7 6930.6 6994.9 7032.1 7065.3 6717.8 6721.8 6762.0 6784.4 6809.9 6712.2 6761.8 6767.3 6768.8 6779.3 7047.9 7063.9 7074.0 7077.0 7118.2 5328.9 5332.3 5344.5 5348.8 5351.9 6665.7 6825.7 6835.5 6912.0 6913.4 6502.9 6540.3 6562.5 6628.2 6637.4 6485.3 6517.3 6525.7 6559.6 6616.6 6319.7 6409.5 6417.0 6457.7 6494.3 6645.4 6654.6 6664.7 6721.5 6723.2 6436.5 6452.5 6466.9 6492.5 6494.2 17:18:57 INFO - PID 4052 | 17:18:57 INFO - PID 4052 | [#5] yui.html Cycles:180 Average:28571.03 Median:19115.17 stddev:42139.33 (220.4%) stddev-sans-first:42206.57 17:18:57 INFO - PID 4052 | Values: 968.3 978.1 996.9 1005.2 1008.5 18595.8 19391.0 19417.1 19418.7 24466.8 23479.5 23571.6 23574.8 23609.3 23654.8 1089.2 1097.3 1107.9 1108.3 1109.7 1106.6 1108.2 1122.4 1127.1 1127.9 1166.9 1171.2 1171.9 1171.9 1175.8 1163.4 1168.4 1170.9 1172.8 1172.8 844.2 851.6 855.1 855.1 856.8 20713.6 20727.0 21015.9 21106.4 21600.4 22736.9 23014.3 23478.5 23680.3 23683.6 17296.7 17650.8 17676.0 17730.5 17809.2 3973.6 4017.6 4028.7 4031.6 4033.9 157168.2 159842.0 159945.0 163132.0 163579.2 17582.5 17624.1 17950.0 17959.3 17968.7 34676.3 35110.5 35698.0 35729.8 35859.8 9055.8 9079.9 9198.8 9204.3 9217.4 4098.6 4253.6 4805.5 4933.5 4955.9 6009.7 6090.2 6137.9 6140.1 6152.8 1135.5 1170.5 1172.0 1181.2 1185.2 706.5 725.6 732.2 748.6 750.0 13159.0 13217.0 13392.9 14064.0 14134.4 722.4 722.5 723.6 727.2 752.8 5966.6 6010.7 6020.1 6033.5 6082.5 148405.0 148715.0 152035.2 152177.2 152405.0 126245.0 126577.0 129832.0 130036.0 131472.0 113274.4 113453.0 113628.0 114910.0 117586.4 10939.3 11056.9 11166.6 11337.7 11374.0 54151.5 54233.9 54666.7 55206.0 56550.2 70036.6 70429.0 70608.0 70703.0 71983.3 17966.2 17975.1 18187.9 18334.9 18376.7 17035.1 17412.8 17563.2 17728.9 21073.9 20773.2 20868.9 20943.1 21131.8 21224.2 19182.8 19409.3 19508.2 19559.5 19587.1 18938.4 18993.4 19030.4 19047.5 19193.9 13798.9 14062.7 14127.9 14271.2 14282.6 15016.0 15157.4 15353.5 15392.7 15470.4 17:18:57 INFO - PID 4052 | -------- Summary: end -------- 17:18:57 INFO - PID 4052 | 17:18:57 INFO - TEST-INFO | 4052: exit 0 17:18:57 INFO - TEST-OK | dromaeo_css | took 1108153ms 17:18:57 INFO - TEST-START | kraken 17:18:57 INFO - Initialising browser for kraken test... 17:18:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50618/getInfo.html -profile /tmp/tmpTlkpun/profile 17:18:57 INFO - TEST-INFO | started process 4427 (/builds/slave/test/build/application/firefox/firefox http://localhost:50618/getInfo.html) 17:19:02 INFO - TEST-INFO | 4427: exit 0 17:19:02 INFO - Browser initialized. 17:19:02 INFO - Running cycle 1/1 for kraken test... 17:19:02 INFO - Using env: {'DISPLAY': ':0', 17:19:02 INFO - 'HOME': '/home/cltbld', 17:19:02 INFO - 'JSGC_DISABLE_POISONING': '1', 17:19:02 INFO - 'LANG': 'en_US.UTF-8', 17:19:02 INFO - 'LANGUAGE': 'en_US:en', 17:19:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:19:02 INFO - 'LOGNAME': 'cltbld', 17:19:02 INFO - 'MAIL': '/var/mail/cltbld', 17:19:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:02 INFO - 'MOZ_CRASHREPORTER': '1', 17:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:19:02 INFO - 'MOZ_NO_REMOTE': '1', 17:19:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:02 INFO - 'NO_EM_RESTART': '1', 17:19:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:02 INFO - 'PWD': '/builds/slave/test', 17:19:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:02 INFO - 'RUST_BACKTRACE': 'full', 17:19:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:19:02 INFO - 'SHELL': '/bin/bash', 17:19:02 INFO - 'SHLVL': '1', 17:19:02 INFO - 'STYLO_FORCE_DISABLED': '1', 17:19:02 INFO - 'TERM': 'linux', 17:19:02 INFO - 'TMOUT': '86400', 17:19:02 INFO - 'USER': 'cltbld', 17:19:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095', 17:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:02 INFO - '_': '/tools/buildbot/bin/python'} 17:19:02 INFO - TEST-INFO | started process 4667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlkpun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:03 INFO - PID 4667 | 17:19:03 INFO - PID 4667 | (/builds/slave/test/build/application/firefox/firefox:4717): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:19:03 INFO - PID 4667 | 17:19:13 INFO - PID 4667 | RSS: Main: 144683008 17:19:13 INFO - PID 4667 | 17:19:16 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50618/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:17 INFO - PID 4667 | RSS: Main: 151584768 17:19:17 INFO - PID 4667 | 17:19:19 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50618/tests/kraken/driver.html?testName=audio-dft) 17:19:20 INFO - PID 4667 | RSS: Main: 152096768 17:19:20 INFO - PID 4667 | 17:19:23 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50618/tests/kraken/driver.html?testName=audio-fft) 17:19:24 INFO - PID 4667 | RSS: Main: 147349504 17:19:24 INFO - PID 4667 | 17:19:26 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50618/tests/kraken/driver.html?testName=audio-oscillator) 17:19:26 INFO - PID 4667 | RSS: Main: 148738048 17:19:26 INFO - PID 4667 | 17:19:28 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:29 INFO - PID 4667 | RSS: Main: 148119552 17:19:29 INFO - PID 4667 | 17:19:32 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50618/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:33 INFO - PID 4667 | RSS: Main: 148099072 17:19:33 INFO - PID 4667 | 17:19:36 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50618/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:37 INFO - PID 4667 | RSS: Main: 150106112 17:19:37 INFO - PID 4667 | 17:19:40 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50618/tests/kraken/driver.html?testName=json-parse-financial) 17:19:40 INFO - PID 4667 | RSS: Main: 151691264 17:19:40 INFO - PID 4667 | 17:19:42 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:42 INFO - PID 4667 | RSS: Main: 151515136 17:19:42 INFO - PID 4667 | 17:19:44 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:44 INFO - PID 4667 | RSS: Main: 151773184 17:19:44 INFO - PID 4667 | 17:19:46 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:47 INFO - PID 4667 | RSS: Main: 148541440 17:19:47 INFO - PID 4667 | 17:19:50 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:51 INFO - PID 4667 | RSS: Main: 148353024 17:19:51 INFO - PID 4667 | 17:19:54 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:54 INFO - PID 4667 | RSS: Main: 148783104 17:19:54 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | Cycle 1(1): loaded http://localhost:50618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50618/tests/kraken/driver.html?testName=ai-astar) 17:19:56 INFO - PID 4667 | RSS: Main: 150716416 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | __start_tp_report 17:19:56 INFO - PID 4667 | _x_x_mozilla_page_load 17:19:56 INFO - PID 4667 | _x_x_mozilla_page_load_details 17:19:56 INFO - PID 4667 | |i|pagename|runs| 17:19:56 INFO - PID 4667 | |0;ai-astar;106;105;104;106;105;108;107;108;105;106 17:19:56 INFO - PID 4667 | |1;audio-beat-detection;117;114;111;113;113;115;123;112;143;109 17:19:56 INFO - PID 4667 | |2;audio-dft;162;162;163;162;162;161;162;162;163;166 17:19:56 INFO - PID 4667 | |3;audio-fft;74;77;75;74;74;73;73;74;74;73 17:19:56 INFO - PID 4667 | |4;audio-oscillator;78;78;78;78;78;79;78;86;78;78 17:19:56 INFO - PID 4667 | |5;imaging-gaussian-blur;110;113;114;115;114;113;115;111;113;114 17:19:56 INFO - PID 4667 | |6;imaging-darkroom;148;150;149;148;149;150;149;150;152;150 17:19:56 INFO - PID 4667 | |7;imaging-desaturate;94;95;96;94;94;95;94;94;94;95 17:19:56 INFO - PID 4667 | |8;json-parse-financial;43;45;45;45;45;44;48;44;42;45 17:19:56 INFO - PID 4667 | |9;json-stringify-tinderbox;38;38;37;37;37;38;37;37;37;38 17:19:56 INFO - PID 4667 | |10;stanford-crypto-aes;73;70;69;68;70;72;73;69;70;70 17:19:56 INFO - PID 4667 | |11;stanford-crypto-ccm;101;103;107;102;104;102;108;101;103;108 17:19:56 INFO - PID 4667 | |12;stanford-crypto-pbkdf2;148;155;150;143;155;157;146;146;154;149 17:19:56 INFO - PID 4667 | |13;stanford-crypto-sha256-iterative;65;58;59;57;59;57;59;71;57;57 17:19:56 INFO - PID 4667 | __end_tp_report 17:19:56 INFO - PID 4667 | __start_cc_report 17:19:56 INFO - PID 4667 | _x_x_mozilla_cycle_collect,713 17:19:56 INFO - PID 4667 | __end_cc_report 17:19:56 INFO - PID 4667 | __startTimestamp1506989996601__endTimestamp 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | ------- Summary: start ------- 17:19:56 INFO - PID 4667 | Number of tests: 14 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.33 (1.3%) stddev-sans-first:1.41 17:19:56 INFO - PID 4667 | Values: 106.0 105.0 104.0 106.0 105.0 108.0 107.0 108.0 105.0 106.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:114.50 stddev:9.90 (8.6%) stddev-sans-first:10.50 17:19:56 INFO - PID 4667 | Values: 117.0 114.0 111.0 113.0 113.0 115.0 123.0 112.0 143.0 109.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 17:19:56 INFO - PID 4667 | Values: 162.0 162.0 163.0 162.0 162.0 161.0 162.0 162.0 163.0 166.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:1.20 (1.6%) stddev-sans-first:1.27 17:19:56 INFO - PID 4667 | Values: 74.0 77.0 75.0 74.0 74.0 73.0 73.0 74.0 74.0 73.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:78.00 stddev:2.51 (3.2%) stddev-sans-first:2.65 17:19:56 INFO - PID 4667 | Values: 78.0 78.0 78.0 78.0 78.0 79.0 78.0 86.0 78.0 78.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.62 (1.4%) stddev-sans-first:1.24 17:19:56 INFO - PID 4667 | Values: 110.0 113.0 114.0 115.0 114.0 113.0 115.0 111.0 113.0 114.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:1.18 (0.8%) stddev-sans-first:1.12 17:19:56 INFO - PID 4667 | Values: 148.0 150.0 149.0 148.0 149.0 150.0 149.0 150.0 152.0 150.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:19:56 INFO - PID 4667 | Values: 94.0 95.0 96.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:45.00 stddev:1.58 (3.5%) stddev-sans-first:1.56 17:19:56 INFO - PID 4667 | Values: 43.0 45.0 45.0 45.0 45.0 44.0 48.0 44.0 42.0 45.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.50 17:19:56 INFO - PID 4667 | Values: 38.0 38.0 37.0 37.0 37.0 38.0 37.0 37.0 37.0 38.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#10] stanford-crypto-aes Cycles:10 Average:70.40 Median:70.00 stddev:1.71 (2.4%) stddev-sans-first:1.54 17:19:56 INFO - PID 4667 | Values: 73.0 70.0 69.0 68.0 70.0 72.0 73.0 69.0 70.0 70.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#11] stanford-crypto-ccm Cycles:10 Average:103.90 Median:103.50 stddev:2.77 (2.7%) stddev-sans-first:2.73 17:19:56 INFO - PID 4667 | Values: 101.0 103.0 107.0 102.0 104.0 102.0 108.0 101.0 103.0 108.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.00 stddev:4.72 (3.1%) stddev-sans-first:4.93 17:19:56 INFO - PID 4667 | Values: 148.0 155.0 150.0 143.0 155.0 157.0 146.0 146.0 154.0 149.0 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:59.00 stddev:4.58 (7.8%) stddev-sans-first:4.47 17:19:56 INFO - PID 4667 | Values: 65.0 58.0 59.0 57.0 59.0 57.0 59.0 71.0 57.0 57.0 17:19:56 INFO - PID 4667 | -------- Summary: end -------- 17:19:56 INFO - PID 4667 | 17:19:56 INFO - PID 4667 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:19:57 INFO - TEST-INFO | 4667: exit 0 17:19:57 INFO - TEST-OK | kraken | took 59694ms 17:19:57 INFO - SUITE-END | took 1167s 17:19:57 INFO - Completed test suite (00:19:27) 17:19:57 INFO - javascript benchmark 17:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9156.140437821337, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3914.138889444322, 3917.764934103954, 3935.488386509754, 3948.6841052715786, 3948.960510394895, 6201.627902325852, 6358.809235722936, 6424.967875160623, 6473.838154046145, 6521.021846722994, 6456.451201647866, 6480.12518310028, 6498.0902673625615, 6505.544611877171, 6520.543561950665, 5713.942860571383, 5766.769329226826, 5777.45114214149, 5812.796552120677, 5847.386024467433, 5766.135079738031, 5796.0, 5810.041343178392, 5816.709164541777, 5871.970640146793, 73.6771517162406, 5717.085266357404, 5737.110747834093, 5753.597248192628, 5885.058390657496, 5739.0, 5806.390329015435, 5820.185174075633, 5824.417558244184, 5832.833433313312, 5680.0627896397045, 5686.516646085088, 5719.628224165457, 5726.68503232322, 5804.448577385142, 6310.684465776739, 6330.746770129189, 6402.519811014193, 6417.39034791694, 6487.545871788977, 6943.6875340609795, 6981.197162326347, 7020.613866237355, 7029.0, 7029.89455158173, 6942.687579058955, 6986.650667466606, 7018.964905175441, 7022.332878376546, 7060.611666358348, 6404.455621272197, 6464.515161362917, 6481.189851268591, 6501.187351581052, 6564.540482166298, 7227.241139680363, 7286.96356518214, 7294.817629559304, 7296.96351518239, 7300.050993370828, 6911.3779759821855, 6915.654217289115, 6955.89566156508, 6977.232504424509, 7023.192332881784, 6887.690053947585, 7025.086738723933, 7035.085438892911, 7108.71565137399, 7116.217216106224, 6908.585484870924, 6931.0, 6992.6853291602, 6993.545419547713, 7003.089598352181, 6993.195782484978, 6996.510244282851, 7011.614361210182, 7021.964890175618, 7032.507724459341, 5130.974345128325, 5147.124988751922, 5151.25306830515, 5156.845294641167, 5161.870953226125, 4574.771261436915, 4628.95371046292, 4683.96952670412, 4684.859454216379, 4687.414073240845, 6356.459700925473, 6381.649009304533, 6426.2931077581425, 6465.450436712932, 6465.450436712932, 6993.811052121152, 7041.753538626123, 7055.6119413431725, 7071.222165561784, 7073.151221853411, 6354.872902541923, 6392.808215753535, 6404.775832845828, 6473.0, 6481.578697384655, 5620.241267428926, 5628.746706398222, 5694.6583205007, 5705.1727499512335, 5713.542916566747, 7095.432365410755, 7245.420366370678, 7245.492815502969, 7245.782626521107, 7255.0, 6954.79135625932, 6955.061066756024, 6980.987756775341, 6987.825304367431, 7036.718531258693, 7172.0, 7221.061262036112, 7249.420046396381, 7251.274872512707, 7314.890276645748, 6856.382925536725, 6918.8616227676175, 6934.895976560255, 6947.4789390796905, 7006.299370063157, 6940.757073502403, 6955.956606509064, 7033.437325014089, 7055.894161587477, 7059.894101588583, 6829.453643708392, 6850.6574671267235, 6851.9657401712675, 6866.4506839453725, 6881.174259088742, 6760.763373281911, 6766.729330826712, 6835.624040677611, 6837.418819400208, 6841.350071743176, 6529.412352888263, 6656.36764507371, 6658.83352916181, 6737.562058466184, 6765.086713293643, 6825.488088393291, 6836.008778726958, 6848.794536163923, 6850.280720524273, 6861.691223895036, 6629.867402652017, 6632.104665870046, 6647.135872336758, 6649.900251496135, 6677.866442671217], "value": 6341.245768364579, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [945.9668911588096, 952.4190243951193, 978.0415193110751, 1003.2074661017797, 1003.5634498992939, 42787.572124278784, 43596.564034359646, 43617.12765744687, 43625.563744362546, 43729.344059839124, 39876.601233987654, 40016.199676006465, 40160.79919600405, 40169.39745903814, 40219.19561608766, 7426.925730742704, 7528.247175282483, 7535.20880307568, 7537.907003484492, 7548.20743821899, 7361.447891408166, 7442.851142977137, 7494.5128566643, 7508.587027713474, 7514.173440921494, 8227.300679442254, 8397.622107005169, 8403.0, 8405.075441701438, 8418.579071046423, 8284.58577071147, 8350.039745429262, 8380.664773409057, 8405.075441701409, 8429.494230346138, 8013.879791803128, 8200.507969521788, 8207.95896020522, 8210.0, 8272.0, 39773.20453590912, 40060.39909401332, 40132.59867401318, 40157.196856063005, 40221.39667904984, 3659.908502287464, 3737.5141231639714, 3738.065483629093, 3740.6446387593137, 3741.5136032315627, 30633.540496892565, 30647.693523064707, 30735.0, 30764.2308942276, 30765.69234307673, 5515.200295957104, 5541.307336582927, 5555.749991250363, 5557.527610153102, 5645.971770141164, 220758.0, 221054.0, 221329.0, 222019.0, 222526.0, 50226.49773502292, 50263.492095237205, 50270.748646256536, 50350.0, 50456.495435045916, 52590.0, 52680.20979685308, 52744.73627631837, 52806.471935280926, 52809.73595132, 17015.489535313962, 17239.22423490946, 17279.74080388795, 17289.740653890203, 17312.740308895376, 14104.435822566982, 14121.505747298796, 14171.85828141726, 14179.716405671828, 14186.85813141876, 15213.771793423108, 15292.770608440882, 15295.847041529441, 15326.080435173924, 15342.15894092716, 6130.63216207029, 6200.3799620037635, 6243.219597550306, 6321.683915804191, 6335.461485773669, 1091.901728844408, 1095.8137116690182, 1101.4162493878257, 1114.147677027075, 1125.836753670713, 25231.747682523306, 25659.743402565735, 25746.227613171635, 25758.613620795328, 26009.73990260111, 1194.6714653470365, 1201.1171788735273, 1214.2107630040368, 1219.1222319929814, 1224.3143839449758, 13551.983601229947, 13587.184768913898, 13830.930845345709, 13847.169169849842, 13847.861521384859, 260193.0, 260698.0, 260846.0, 261059.0, 261674.0, 56817.43182568204, 57019.144712829344, 60044.0, 61087.38912610906, 61358.38641613616, 1519.7112548615728, 1538.3231378193782, 1538.569200623827, 1552.9922350388401, 1553.2156261088305, 30472.0, 30792.84603576968, 30826.0, 30832.383352332377, 30897.691023089483, 40394.0, 40501.1899762009, 40543.0, 40577.391339129346, 40608.59391406048, 227311.0, 227839.0, 227980.0, 228189.0, 228815.0, 33693.83153084219, 33862.32275354528, 34188.658113419544, 34217.828910855285, 34314.14214644654, 44175.33736993883, 44183.77908110568, 44208.0, 44316.55683443253, 44337.11325773531, 33490.49764253587, 33491.0, 33857.49213761746, 33923.83038084794, 34249.82875085609, 32515.0, 32828.0, 32977.505337420436, 33397.49903751494, 33654.326913461104, 39272.80363598164, 39455.2108957825, 39487.2102557953, 39508.40737388999, 39596.0, 32177.678223217466, 32359.400267523844, 32557.0, 32798.34403311968, 33028.83485582557, 24785.62821557642, 25288.74711252864, 25315.240542783748, 25850.0, 26011.73988260093], "value": 18394.2370455564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.2260370029447, 636.2374964344593, 640.8599423518682, 644.7580188702461, 648.8248074264268, 23150.0, 23707.407314817137, 23855.045798168052, 24006.039758409665, 24022.75977240227, 25520.872395637994, 25706.0, 25757.48485030303, 25880.74119258807, 25903.740962590367, 6267.2165979252595, 6351.333110023439, 6462.935370646281, 6508.31662675417, 6516.869662606745, 6537.803865884031, 6632.2704502504685, 6633.568818026837, 6636.867262654744, 6640.701168447432, 6554.311797261291, 6570.080188773575, 6597.901031484532, 6793.626350550718, 6834.897476537856, 6696.564723292995, 6724.932750672479, 6727.495437842182, 6732.124823772878, 6737.93262067378, 5960.4635582797755, 6143.078538219258, 6348.523860710419, 6359.20509936258, 6367.522435817286, 30334.241643959078, 31029.0, 31039.844800776078, 31042.379152417052, 31089.0, 2217.534317793249, 2246.663000549914, 2248.8875556222124, 2252.842301038928, 2261.638137897945, 20298.797012029838, 20327.390178294674, 20672.689909651366, 20711.8964405177, 21073.367798966057, 2567.8844451999703, 2590.119359417788, 2608.2696844883462, 2678.383971686523, 2682.1149020823277, 123507.0, 129423.35288323593, 154517.0, 158935.2053239738, 159254.0, 16057.919710401373, 16154.345978907288, 16412.589685257964, 16887.408940687015, 17151.399701010403, 26449.206523804318, 26538.275012124537, 26549.0, 26648.60027099595, 26674.733252667615, 10303.9484802577, 10471.94764026175, 10572.0, 10596.629117980834, 10677.9466102669, 9458.871753855328, 9530.571124299424, 9546.570404331822, 9554.423520119102, 9634.518274086267, 10003.24975626831, 10021.0, 10072.496375181358, 10189.439580822978, 10248.489120165606, 2962.6592941811537, 2962.7037296270632, 3016.155476466593, 3029.621297337833, 3047.4362242985117, 1042.020500729312, 1045.17953406577, 1048.8269435543202, 1050.695298363466, 1051.4742628685658, 20493.0, 20535.0, 20772.06525706347, 20781.480462988246, 20788.27241046556, 1095.9178061645248, 1105.8617672790901, 1111.155521803419, 1118.8881111888745, 1122.6968718445974, 11493.367864767351, 11709.531618735326, 11750.77445787952, 11752.823707644393, 11797.469113889896, 544521.0, 564575.0, 569701.0, 575799.0, 577708.0, 128617.0, 131814.34092829475, 132743.3362833199, 134089.0, 134910.0, 1128.4301427779083, 1174.2895548193392, 1222.5965431407615, 1223.9877601224052, 1283.5635883799553, 21567.784322156578, 21791.891040544695, 21951.780482194972, 21989.450263742896, 22030.449238768517, 63025.36974630378, 64043.0, 64512.67743661252, 64995.0, 66504.0, 78413.60793195998, 78616.0, 78621.0, 81110.59444702975, 82627.17372826194, 15732.370705171665, 16014.439494617633, 16040.197990100214, 16062.518124456285, 16090.919545402197, 23905.402364941016, 24018.879905601058, 24043.278701638978, 24057.759422406252, 24443.877780610983, 19131.13909874031, 19171.137298821865, 19736.210551577777, 19919.502012449804, 19919.502012449804, 17387.56531086733, 17629.20668569892, 17800.13948390933, 18082.457526274233, 18302.63394732071, 19091.0, 20031.59936801285, 20235.79764202339, 20241.392758217276, 20359.287424940056, 15755.606109847346, 15806.446774363301, 15809.762853557437, 15827.129507876716, 15848.683026339639, 19656.90171549133, 19725.24727745041, 19873.801261987195, 19918.70121948143, 20022.49943751418], "value": 12848.449414855466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.4415799917033, 1504.6990601879627, 1513.1299502785887, 1515.9545213643592, 1542.4909779772677, 16894.91552542237, 17552.912235438806, 17559.209835557398, 17573.29706811726, 17575.648487030267, 16943.32226710933, 17072.231749571267, 17080.145992700378, 17111.74332385015, 17146.571335716613, 2836.8297902125837, 2877.5539791332376, 2921.0652591170833, 2924.1958461423174, 2927.443785680714, 2790.8185967912123, 2875.0, 2884.0915111739737, 2888.4078763853463, 2890.739833414992, 2698.7031426543163, 2878.568214767781, 2948.808327458719, 2964.9258768530744, 2972.2420782700488, 2841.0, 2844.1183233197776, 2863.1410576827075, 2872.669642991051, 2874.7843911706705, 2747.2719729271757, 2770.9722902770914, 2777.916662500128, 2792.860356982163, 2821.562657788046, 16326.510204693877, 16737.0, 16784.748228776578, 16918.915405422893, 16951.406700765536, 8161.63272652732, 8417.74746757592, 8434.40959132861, 8439.156084391512, 8443.408961372645, 5433.538149257279, 5552.694601796899, 5630.634008789416, 5646.971765141189, 5778.451047150514, 2086.7078608994752, 2123.5115923337567, 2127.914883404662, 2157.7194964654495, 2195.506011147479, 30506.08481745529, 31305.530417043763, 31515.369692606248, 31579.0, 31790.04629861108, 7306.5981371024045, 7332.816679582947, 7358.300961408658, 7464.178940316561, 7483.925160748432, 20442.591148176954, 20478.692819607717, 20567.0, 20605.89697051535, 20684.79315206859, 8186.877196842052, 8339.457935234312, 8362.247397734232, 8367.03779065403, 8369.623366948503, 7619.809504762315, 7673.923260767432, 7750.379969602418, 7888.802779930433, 7892.368610511146, 5903.881922361528, 5932.377100404482, 6021.066734656135, 6093.0, 6095.4818840398175, 1701.8723595730369, 1723.9482815515555, 1742.4946765438135, 1756.1307152959366, 1776.7246076858107, 984.7390441532999, 990.4997976022063, 1006.2302338710892, 1018.4856647393019, 1023.9283250172416, 8665.263452606472, 8668.696595619123, 8676.696315628922, 8891.333150013776, 9003.279737620975, 798.7404093669464, 798.8681867491915, 801.9679212831421, 803.445622520459, 813.3168138763467, 5361.892762144813, 5467.5625949923915, 5490.203920431595, 5514.751836167382, 5536.335639723178, 23990.640140397907, 24994.875025624755, 25038.624420633703, 25043.0, 25128.120515782226, 23788.0, 24596.262112136665, 24597.0, 25954.480910382063, 26021.089261875743, 10982.670519884416, 11225.158113141548, 12632.11575189728, 12745.362731863555, 13179.472821087049, 9955.303128780915, 10067.0, 10107.292489525662, 10323.63867264642, 10334.173266138841, 20939.685904711136, 21687.132514699235, 21753.782462175808, 21768.56462870702, 22093.77906220917, 22180.223692170697, 22185.223517176822, 22199.112035519043, 22279.0, 22629.547409052055, 12974.481020759442, 13179.275139867399, 13188.934055329662, 13213.537526186537, 13219.735605288033, 15191.088534687955, 15412.075275483507, 15586.454474093352, 15631.218439078228, 15661.21693915277, 12580.0, 12643.114981951176, 12770.61688149357, 13086.214827110403, 13197.076204665582, 12069.27584344942, 12132.514699411924, 12206.633800985985, 12279.263244205376, 12357.629271121881, 10961.177911656498, 11045.558177672803, 11097.11223102166, 11099.056580190774, 11099.611513596985, 8463.74608761738, 8560.229579337889, 8641.95679021626, 8643.611037503202, 8832.558372081241, 8634.179752923463, 8637.611307491052, 8686.956565217386, 8811.911880881109, 8845.203931646183], "value": 7379.795504338957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5775694957932, 565.2002416580539, 573.166043406843, 579.0, 583.6848102024906, 6231.781887633933, 6280.591761535497, 6330.65181415022, 6360.4911607071435, 6368.904466433001, 6239.188905442297, 6249.9062514062325, 6293.559450838432, 6297.149884765556, 6301.2753533343675, 5175.327207463025, 5192.4547922468255, 5215.973920130413, 5223.529882310591, 5236.633435659505, 4927.507249275061, 5068.34111565496, 5151.948480515203, 5154.716490593016, 5189.740512974355, 5030.421501527317, 5058.747062646871, 5067.163917953533, 5082.415522214956, 5105.361829771278, 5034.798608055673, 5050.343455350818, 5051.2423136529815, 5075.238714192864, 5099.847004589849, 4562.178807814592, 4599.747013914233, 4627.329037289608, 4630.490646028934, 4657.6273898088075, 6273.6235825850135, 6284.811455656338, 6286.654234017127, 6315.810525684236, 6320.27316858558, 5940.910886336708, 5949.631584735492, 6005.939940600581, 6013.526685961923, 6018.127371531147, 6603.306652801435, 6634.601923884534, 6667.299933507009, 6667.466602671775, 6702.262751097375, 5138.486151384832, 5141.691498510101, 5175.4991052594705, 5183.222516622499, 5195.558377537914, 6775.491838112112, 6909.7581584644795, 7017.47368947331, 7039.542429742101, 7040.471964602624, 5281.709505977208, 5284.841454756363, 5313.521783039468, 5314.3091398117995, 5336.7865285388925, 5347.144456886957, 5349.679019258779, 5403.0814761489855, 5411.2965314508865, 5420.891582168413, 5836.358000619928, 5852.209951656557, 5893.469587737124, 5964.910526342108, 6009.519238460913, 6735.8989615155815, 6748.460123190133, 6807.863842723118, 6821.69302381394, 6822.761203357859, 1852.9258829646662, 1859.414284500405, 1863.4782260966952, 1882.2282864025683, 1889.990550047241, 1275.101053757099, 1328.136711137768, 1332.8733770291806, 1338.772408690525, 1349.3657980749033, 6165.753369865245, 6192.721327540272, 6201.472874805692, 6264.248290205204, 6296.338884417162, 6674.966625166843, 6677.933220667828, 6727.562708423937, 6746.414592570742, 6824.112865327475, 6170.642458659087, 6207.379262073757, 6235.844103897439, 6257.530685198628, 6300.810975670737, 3559.430491121408, 3576.964230357715, 3613.223157021253, 3619.5113659656135, 3629.491871138043, 7081.221065682771, 7085.964570177116, 7097.822554436078, 7126.536775109601, 7138.821529461805, 6945.583265004116, 6954.4436445084275, 7013.368796808311, 7029.0, 7058.752943646948, 6914.723411063501, 6930.584164950119, 6994.93005069953, 7032.05067315916, 7065.304326961595, 6717.832054198684, 6721.764738234334, 6761.966190169018, 6784.3894049535775, 6809.944458608924, 6712.228093769279, 6761.830954226184, 6767.255601883888, 6768.830779230559, 6779.288174741581, 7047.859042819013, 7063.894041589278, 7074.0, 7076.964615176891, 7118.181409137808, 5328.920066199088, 5332.280142180756, 5344.4922732340365, 5348.786048558014, 5351.892962140658, 6665.66671666405, 6825.726970921306, 6835.487338449736, 6911.965440172767, 6913.412359949461, 6502.934970650233, 6540.313267106885, 6562.5406221564035, 6628.204615446178, 6637.402633762985, 6485.254195767548, 6517.250516190698, 6525.738970441129, 6559.573627714183, 6616.643588064339, 6319.724899036251, 6409.487241020801, 6416.967915160394, 6457.7094030767785, 6494.253160886558, 6645.401913827779, 6654.567453115532, 6664.666766661744, 6721.529492935448, 6723.226828914738, 6436.517261205335, 6452.451541619015, 6466.935330646634, 6492.545521813617, 6494.188226471691], "value": 5248.765460064025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [968.2689569375125, 978.0854900667877, 996.9052939970704, 1005.1857995024036, 1008.4957521239382, 18595.814041859594, 19391.0, 19417.126229319678, 19418.708719369202, 24466.75533244667, 23479.530409391802, 23571.646425303636, 23574.764252357472, 23609.291721248348, 23654.76345236547, 1089.1559041742653, 1097.2757979733337, 1107.9224454288203, 1108.279618248137, 1109.7447587054942, 1106.6403418888854, 1108.2242430298784, 1122.354646078504, 1127.10958342909, 1127.9154063445233, 1166.8716441191461, 1171.1509155862018, 1171.8652354979158, 1171.8945294923456, 1175.8001139806254, 1163.4241050679882, 1168.4449886304023, 1170.8594968603736, 1172.7537217184358, 1172.7947609168405, 844.1980118887082, 851.6337974670889, 855.0637052427581, 855.085058986878, 856.7900864288227, 20713.5857282855, 20727.0, 21015.8949205253, 21106.366808995754, 21600.351989440343, 22736.88631556848, 23014.309570712907, 23478.530429391318, 23680.28959131229, 23683.644745328835, 17296.654066918592, 17650.823491765048, 17676.0, 17730.468085957444, 17809.19858606366, 3973.6225058619384, 4017.5982401759884, 4028.7179897407195, 4031.596840315974, 4033.878983630496, 157168.2141589285, 159842.0, 159945.0, 163132.0, 163579.1821040899, 17582.472525824247, 17624.118794060247, 17950.0, 17959.281628734967, 17968.730469042974, 34676.30647387038, 35110.473342899364, 35698.0, 35729.82135089308, 35859.82070089633, 9055.773605659911, 9079.863802042975, 9198.77003074915, 9204.263658907272, 9217.354785164975, 4098.569650186747, 4253.617174454252, 4805.543473370024, 4933.531314525115, 4955.925661115086, 6009.669468179205, 6090.23872015998, 6137.9079313810325, 6140.109684095781, 6152.815415537541, 1135.4606561883204, 1170.4849866058908, 1171.9589814356627, 1181.1908842442954, 1185.1763024697925, 706.4630880530833, 725.6081715873369, 732.168988198388, 748.569572495817, 749.9700011999568, 13159.0, 13217.0, 13392.933035334761, 14064.015518913578, 14134.36395362211, 722.4184531452231, 722.458156382713, 723.6237156678498, 727.1637616740685, 752.766642340876, 5966.612170208922, 6010.66941318223, 6020.127081573235, 6033.5474839387225, 6082.482988945901, 148405.0, 148715.0, 152035.23982380237, 152177.23911380593, 152405.0, 126245.0, 126577.0, 129832.0, 130036.0, 131472.0, 113274.43362783133, 113453.0, 113628.0, 114910.0, 117586.41206794082, 10939.343639381663, 11056.944715276371, 11166.609168679057, 11337.659870203906, 11374.0, 54151.458485414645, 54233.915321694134, 54666.72666636641, 55206.0, 56550.15174772299, 70036.64981675263, 70429.0, 70608.0, 70703.0, 71983.28016719766, 17966.191521381832, 17975.101244937963, 18187.909060454615, 18334.908325458287, 18376.724349135042, 17035.148242588068, 17412.82587174163, 17563.209655565275, 17728.91135544314, 21073.89463052675, 20773.169073236902, 20868.895655521625, 20943.057562409424, 21131.788682113598, 21224.151033959086, 19182.80817191866, 19409.32067377635, 19508.21967121299, 19559.511012224808, 19587.118579663664, 18938.43184704406, 18993.385562227366, 19030.42908712741, 19047.52381190481, 19193.90403047976, 13798.93100534491, 14062.718745625234, 14127.858721413066, 14271.21508317011, 14282.642933926734, 15016.0, 15157.393704251706, 15353.539393818204, 15392.692146157238, 15470.381184752483], "value": 10149.400997907025, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 106.0, 105.0, 108.0, 107.0, 108.0, 105.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 111.0, 113.0, 113.0, 115.0, 123.0, 112.0, 143.0, 109.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 166.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 74.0, 74.0, 73.0, 73.0, 74.0, 74.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 86.0, 78.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 115.0, 114.0, 113.0, 115.0, 111.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 148.0, 149.0, 150.0, 149.0, 150.0, 152.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 45.0, 45.0, 45.0, 44.0, 48.0, 44.0, 42.0, 45.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 38.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 69.0, 68.0, 70.0, 72.0, 73.0, 69.0, 70.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 107.0, 102.0, 104.0, 102.0, 108.0, 101.0, 103.0, 108.0], "value": 103.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 155.0, 150.0, 143.0, 155.0, 157.0, 146.0, 146.0, 154.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 58.0, 59.0, 57.0, 59.0, 57.0, 59.0, 71.0, 57.0, 57.0], "value": 59.9, "unit": "score"}]}]} 17:19:57 INFO - Return code: 0 17:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:19:57 INFO - # TBPL SUCCESS # 17:19:57 INFO - Running post-action listener: _package_coverage_data 17:19:57 INFO - Running post-action listener: _resource_record_post_action 17:19:57 INFO - [mozharness: 2017-10-03 00:19:57.399963Z] Finished run-tests step (success) 17:19:57 INFO - Running post-run listener: _resource_record_post_run 17:19:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 9076736; Write bytes: 452526080; Read time: 2532; Write time: 408148 17:19:57 INFO - TinderboxPrint: CPU usage
13.1% 17:19:57 INFO - TinderboxPrint: I/O read bytes / time
9,076,736 / 2,532 17:19:57 INFO - TinderboxPrint: I/O write bytes / time
452,526,080 / 408,148 17:19:57 INFO - TinderboxPrint: CPU idle
8,217.1 (86.9%) 17:19:57 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 17:19:57 INFO - TinderboxPrint: Swap in / out
0 / 0 17:19:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 63623168; Read time: 0; Write time: 26832 17:19:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:19:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 9076736; Write bytes: 282521600; Read time: 2532; Write time: 239536 17:19:58 INFO - Running post-run listener: _upload_blobber_files 17:19:58 INFO - Blob upload gear active. 17:19:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:19:58 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 17:19:58 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'] 17:19:58 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 17:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:59 INFO - (blobuploader) - INFO - Done attempting. 17:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:00 INFO - (blobuploader) - INFO - Done attempting. 17:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:01 INFO - (blobuploader) - INFO - Done attempting. 17:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:08 INFO - (blobuploader) - INFO - Done attempting. 17:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:08 INFO - Return code: 0 17:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5fefdc653ba20a413198af7944093a084592960404017eb379296dcafbba77c62ab2ea28d2ba4e3ad4aa1c10c76034bc94fbfccf27a8c1837f7a773169bf51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b8b6e4488bb745f10760a4dece0d642e5ad0057985185d461a93c0dc29ec70b9edc6c8486092d0afb3e791d15bdd21fd2dc6ff767f4a3a584d60bd00d86474e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e7ab8aea4fa20c6b29b68b4ca67a900fa911e0e87f0332e2d5026cc1830890541b7e6ef5115c504044590f9e195c6a5270c415632be9f15994c4d9a4343ea9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eccbfc2593cb1192599c6ecf4c54b7ab4b7b00e821a2757818a379dc48814675da34476d9589f937cd8178441da6803ca09db5fc43c613c2436470e34930bbd8"} 17:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:08 INFO - Contents: 17:20:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5fefdc653ba20a413198af7944093a084592960404017eb379296dcafbba77c62ab2ea28d2ba4e3ad4aa1c10c76034bc94fbfccf27a8c1837f7a773169bf51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b8b6e4488bb745f10760a4dece0d642e5ad0057985185d461a93c0dc29ec70b9edc6c8486092d0afb3e791d15bdd21fd2dc6ff767f4a3a584d60bd00d86474e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e7ab8aea4fa20c6b29b68b4ca67a900fa911e0e87f0332e2d5026cc1830890541b7e6ef5115c504044590f9e195c6a5270c415632be9f15994c4d9a4343ea9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eccbfc2593cb1192599c6ecf4c54b7ab4b7b00e821a2757818a379dc48814675da34476d9589f937cd8178441da6803ca09db5fc43c613c2436470e34930bbd8"} 17:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:08 INFO - Copying logs to upload dir... 17:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.280619 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 17:20:08.872965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:20:08.876937) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 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/fa5fefdc653ba20a413198af7944093a084592960404017eb379296dcafbba77c62ab2ea28d2ba4e3ad4aa1c10c76034bc94fbfccf27a8c1837f7a773169bf51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b8b6e4488bb745f10760a4dece0d642e5ad0057985185d461a93c0dc29ec70b9edc6c8486092d0afb3e791d15bdd21fd2dc6ff767f4a3a584d60bd00d86474e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e7ab8aea4fa20c6b29b68b4ca67a900fa911e0e87f0332e2d5026cc1830890541b7e6ef5115c504044590f9e195c6a5270c415632be9f15994c4d9a4343ea9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eccbfc2593cb1192599c6ecf4c54b7ab4b7b00e821a2757818a379dc48814675da34476d9589f937cd8178441da6803ca09db5fc43c613c2436470e34930bbd8"} build_url:https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/JOL-TkI-RMSclPLlj1z2Uw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5fefdc653ba20a413198af7944093a084592960404017eb379296dcafbba77c62ab2ea28d2ba4e3ad4aa1c10c76034bc94fbfccf27a8c1837f7a773169bf51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b8b6e4488bb745f10760a4dece0d642e5ad0057985185d461a93c0dc29ec70b9edc6c8486092d0afb3e791d15bdd21fd2dc6ff767f4a3a584d60bd00d86474e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e7ab8aea4fa20c6b29b68b4ca67a900fa911e0e87f0332e2d5026cc1830890541b7e6ef5115c504044590f9e195c6a5270c415632be9f15994c4d9a4343ea9f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eccbfc2593cb1192599c6ecf4c54b7ab4b7b00e821a2757818a379dc48814675da34476d9589f937cd8178441da6803ca09db5fc43c613c2436470e34930bbd8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:20:08.905459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:20:08.905767) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506979086.758858-2122950095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:20:08.991399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:20:08.991711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:20:08.991987) ========= ========= Total master_lag: 0.23 =========