builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1507027350.46 results: success (0) revision: 11fe0a2895aab26c57bcfe61b3041d7837e954cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.461333) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.461779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.462386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.555714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.556303) ========= 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-1507014692.838275-1376920695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 03:42: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% 66.0M=0s 2017-10-03 03:42:30 (66.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165403 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.790096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.790380) ========= 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-1507014692.838275-1376920695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018349 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.894231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:30.894534) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 11fe0a2895aab26c57bcfe61b3041d7837e954cd --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 11fe0a2895aab26c57bcfe61b3041d7837e954cd --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-1507014692.838275-1376920695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 03:42:30,950 truncating revision to first 12 chars 2017-10-03 03:42:30,950 Setting DEBUG logging. 2017-10-03 03:42:30,950 attempt 1/10 2017-10-03 03:42:30,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/11fe0a2895aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 03:42:31,328 unpacking tar archive at: mozilla-central-11fe0a2895aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:31.597693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:31.598049) ========= script_repo_revision: 11fe0a2895aab26c57bcfe61b3041d7837e954cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:31.598448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:31.598711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 03:42:31.614981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-03 03:42:31.615592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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-1507014692.838275-1376920695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:42:31 INFO - MultiFileLogger online at 20171003 03:42:31 in /builds/slave/test 03:42:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:42:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:42:31 INFO - {'append_to_log': False, 03:42:31 INFO - 'base_work_dir': '/builds/slave/test', 03:42:31 INFO - 'blob_upload_branch': 'Firefox', 03:42:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:42:31 INFO - 'branch': 'Firefox', 03:42:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:42:31 INFO - 'code_coverage': False, 03:42:31 INFO - 'config_files': ('talos/linux_config.py',), 03:42:31 INFO - 'default_actions': ('clobber', 03:42:31 INFO - 'read-buildbot-config', 03:42:31 INFO - 'download-and-extract', 03:42:31 INFO - 'populate-webroot', 03:42:31 INFO - 'create-virtualenv', 03:42:31 INFO - 'install', 03:42:31 INFO - 'setup-mitmproxy', 03:42:31 INFO - 'run-tests'), 03:42:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:42:31 INFO - 'disable_ccov_upload': False, 03:42:31 INFO - 'disable_stylo': False, 03:42:31 INFO - 'download_minidump_stackwalk': True, 03:42:31 INFO - 'download_symbols': 'ondemand', 03:42:31 INFO - 'enable_stylo': False, 03:42:31 INFO - 'enable_webrender': False, 03:42:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:42:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:42:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:42:31 INFO - 'gecko_profile': False, 03:42:31 INFO - 'gecko_profile_interval': 0, 03:42:31 INFO - 'installer_path': 'installer.exe', 03:42:31 INFO - 'log_level': 'info', 03:42:31 INFO - 'log_name': 'talos', 03:42:31 INFO - 'log_to_console': True, 03:42:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:42:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:42:31 INFO - 'opt_config_files': (), 03:42:31 INFO - 'pip_index': False, 03:42:31 INFO - 'suite': 'dromaeojs-e10s', 03:42:31 INFO - 'system_bits': '32', 03:42:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:42:31 INFO - 'title': 'talos-linux64-ix-019', 03:42:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:42:31 INFO - 'use_talos_json': True, 03:42:31 INFO - 'verify': 'False', 03:42:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:42:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:42:31 INFO - 'work_dir': 'build'} 03:42:31 INFO - [mozharness: 2017-10-03 10:42:31.885548Z] Running clobber step. 03:42:31 INFO - Running pre-action listener: _resource_record_pre_action 03:42:31 INFO - Running main action method: clobber 03:42:31 INFO - rmtree: /builds/slave/test/build 03:42:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:42:32 INFO - Running post-action listener: _resource_record_post_action 03:42:32 INFO - [mozharness: 2017-10-03 10:42:32.854994Z] Finished clobber step (success) 03:42:32 INFO - [mozharness: 2017-10-03 10:42:32.855093Z] Running read-buildbot-config step. 03:42:32 INFO - Running pre-action listener: _resource_record_pre_action 03:42:32 INFO - Running main action method: read_buildbot_config 03:42:32 INFO - Using buildbot properties: 03:42:32 INFO - { 03:42:32 INFO - "project": "", 03:42:32 INFO - "product": "firefox", 03:42:32 INFO - "who": "archaeopteryx@coole-files.de", 03:42:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:42:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:42:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:42:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:42:32 INFO - "stage_platform": "linux64-qr", 03:42:32 INFO - "basedir": "/builds/slave/test", 03:42:32 INFO - "buildnumber": 96, 03:42:32 INFO - "platform": "ubuntu64_hw_qr", 03:42:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:42:32 INFO - "slavebuilddir": "test", 03:42:32 INFO - "taskId": "ZELiokXqR46v1tN4qZV5aA", 03:42:32 INFO - "branch": "mozilla-central", 03:42:32 INFO - "script_repo_revision": "production", 03:42:32 INFO - "revision": "11fe0a2895aab26c57bcfe61b3041d7837e954cd", 03:42:32 INFO - "slavename": "talos-linux64-ix-019", 03:42:32 INFO - "repo_path": "mozilla-central" 03:42:32 INFO - } 03:42:32 INFO - Finding installer, test and symbols from parent task. 03:42:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZELiokXqR46v1tN4qZV5aA'}, attempt #1 03:42:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZELiokXqR46v1tN4qZV5aA'}, attempt #1 03:42:33 INFO - Task dependencies: S7Bgu-exQIOQMwslDlMfzQ 03:42:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ'}, attempt #1 03:42:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 03:42:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.test_packages.json 03:42:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.crashreporter-symbols.zip 03:42:34 INFO - Running post-action listener: _resource_record_post_action 03:42:34 INFO - [mozharness: 2017-10-03 10:42:34.239498Z] Finished read-buildbot-config step (success) 03:42:34 INFO - [mozharness: 2017-10-03 10:42:34.239716Z] Running download-and-extract step. 03:42:34 INFO - Running pre-action listener: _resource_record_pre_action 03:42:34 INFO - Running main action method: download_and_extract 03:42:34 INFO - mkdir: /builds/slave/test/build/tests 03:42: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')]} 03:42:34 INFO - trying https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.test_packages.json 03:42:34 INFO - Downloading https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:42:34 INFO - Downloaded 989 bytes. 03:42:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:42:34 INFO - Using the following test package requirements: 03:42:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:42:34 INFO - u'common': [u'target.common.tests.zip'], 03:42:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:42:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:42:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:42:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:42:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:42:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:42:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:42:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:42:34 INFO - u'target.web-platform.tests.tar.gz'], 03:42:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:42:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.common.tests.zip 03:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.common.tests.zip into memory 03:42:36 INFO - Content-Length response header: 55304255 03:42:36 INFO - Bytes received: 55304255 03:42:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.talos.tests.zip 03:42:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:42:47 INFO - Fetch https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.talos.tests.zip into memory 03:42:48 INFO - Content-Length response header: 14522427 03:42:48 INFO - Bytes received: 14522427 03:42: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')]} 03:42:48 INFO - trying https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 03:42:48 INFO - Downloading https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:42:51 INFO - Downloaded 61681633 bytes. 03:42:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 03:42:51 INFO - mkdir: /builds/slave/test/properties 03:42:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:51 INFO - Contents: 03:42:51 INFO - build_url:https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 03:42:51 INFO - Running post-action listener: _resource_record_post_action 03:42:51 INFO - Running post-action listener: find_tests_for_verification 03:42:51 INFO - Running post-action listener: set_extra_try_arguments 03:42:51 INFO - [mozharness: 2017-10-03 10:42:51.152795Z] Finished download-and-extract step (success) 03:42:51 INFO - [mozharness: 2017-10-03 10:42:51.152894Z] Running populate-webroot step. 03:42:51 INFO - Running pre-action listener: _resource_record_pre_action 03:42:51 INFO - Running main action method: populate_webroot 03:42:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['tresize', 03:42:51 INFO - 'tcanvasmark']}, 03:42:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['dromaeo_css', 03:42:51 INFO - 'kraken']}, 03:42:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'tests': ['damp', 'tps']}, 03:42:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['damp', 'tps']}, 03:42:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['dromaeo_dom']}, 03:42:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:42:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['basic_compositor_video', 03:42:51 INFO - 'glvideo']}, 03:42:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:42:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['ts_paint_webext', 03:42:51 INFO - 'tp5o_webext']}, 03:42:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:51 INFO - 'ts_paint', 03:42:51 INFO - 'tpaint', 03:42:51 INFO - 'sessionrestore', 03:42:51 INFO - 'sessionrestore_many_windows', 03:42:51 INFO - 'sessionrestore_no_auto_restore', 03:42:51 INFO - 'tabpaint', 03:42:51 INFO - 'cpstartup']}, 03:42:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['a11yr', 03:42:51 INFO - 'ts_paint', 03:42:51 INFO - 'tpaint', 03:42:51 INFO - 'sessionrestore', 03:42:51 INFO - 'sessionrestore_many_windows', 03:42:51 INFO - 'sessionrestore_no_auto_restore', 03:42:51 INFO - 'tabpaint', 03:42:51 INFO - 'cpstartup']}, 03:42:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:42:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:42:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['perf_reftest_singletons']}, 03:42:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['perf_reftest']}, 03:42:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:51 INFO - 'tsvgr_opacity', 03:42:51 INFO - 'tart', 03:42:51 INFO - 'tscrollx', 03:42:51 INFO - 'tsvg_static']}, 03:42:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['tsvgx', 03:42:51 INFO - 'tsvgr_opacity', 03:42:51 INFO - 'tart', 03:42:51 INFO - 'tscrollx', 03:42:51 INFO - 'tsvg_static']}, 03:42:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:42:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--disable-stylo'], 03:42:51 INFO - 'tests': ['tp5o']}, 03:42:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:51 INFO - 'talos_options': ['--mitmproxy', 03:42:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:51 INFO - '--firstNonBlankPaint'], 03:42:51 INFO - 'tests': ['tp6_google', 03:42:51 INFO - 'tp6_youtube', 03:42:51 INFO - 'tp6_amazon', 03:42:51 INFO - 'tp6_facebook']}, 03:42:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:51 INFO - 'talos_options': ['--disable-stylo', 03:42:51 INFO - '--mitmproxy', 03:42:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:51 INFO - '--firstNonBlankPaint'], 03:42:51 INFO - 'tests': ['tp6_google', 03:42:51 INFO - 'tp6_youtube', 03:42:51 INFO - 'tp6_amazon', 03:42:51 INFO - 'tp6_facebook']}, 03:42:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:51 INFO - 'talos_options': ['--stylo-threads=1', 03:42:51 INFO - '--mitmproxy', 03:42:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:51 INFO - '--firstNonBlankPaint'], 03:42:51 INFO - 'tests': ['tp6_google', 03:42:51 INFO - 'tp6_youtube', 03:42:51 INFO - 'tp6_amazon', 03:42:51 INFO - 'tp6_facebook']}, 03:42:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--xperf_path', 03:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:51 INFO - 'tests': ['tp5n']}, 03:42:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:51 INFO - 'talos_options': ['--disable-stylo', 03:42:51 INFO - '--xperf_path', 03:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:51 INFO - 'tests': ['tp5n']}}} 03:42:51 INFO - Running post-action listener: _resource_record_post_action 03:42:51 INFO - [mozharness: 2017-10-03 10:42:51.168769Z] Finished populate-webroot step (success) 03:42:51 INFO - [mozharness: 2017-10-03 10:42:51.168859Z] Running create-virtualenv step. 03:42:51 INFO - Running pre-action listener: _resource_record_pre_action 03:42:51 INFO - Running main action method: create_virtualenv 03:42:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:42:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:42:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:42:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:53 INFO - Installing pip...............done. 03:42:53 INFO - Return code: 0 03:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:42:53 INFO - Reading from file tmpfile_stdout 03:42:53 INFO - Output received: 03:42:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:42:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:42: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', 'pip>=1.5'] in /builds/slave/test/build 03:42: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 pip>=1.5 03:42:53 INFO - Using env: {'DISPLAY': ':0', 03:42:53 INFO - 'HOME': '/home/cltbld', 03:42:53 INFO - 'LANG': 'en_US.UTF-8', 03:42:53 INFO - 'LANGUAGE': 'en_US:en', 03:42:53 INFO - 'LOGNAME': 'cltbld', 03:42:53 INFO - 'MAIL': '/var/mail/cltbld', 03:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:53 INFO - 'MOZ_NO_REMOTE': '1', 03:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:53 INFO - 'NO_EM_RESTART': '1', 03:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:53 INFO - 'PWD': '/builds/slave/test', 03:42:53 INFO - 'SHELL': '/bin/bash', 03:42:53 INFO - 'SHLVL': '1', 03:42:53 INFO - 'TERM': 'linux', 03:42:53 INFO - 'TMOUT': '86400', 03:42:53 INFO - 'USER': 'cltbld', 03:42:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:53 INFO - '_': '/tools/buildbot/bin/python'} 03:42:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:42:54 INFO - Downloading/unpacking pip>=1.5 03:42:54 INFO - Running setup.py egg_info for package pip 03:42:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:54 INFO - Installing collected packages: pip 03:42:54 INFO - Found existing installation: pip 1.1 03:42:54 INFO - Uninstalling pip: 03:42:54 INFO - Successfully uninstalled pip 03:42:54 INFO - Running setup.py install for pip 03:42:54 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:54 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:42:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:42:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:42:54 INFO - Successfully installed pip 03:42:54 INFO - Cleaning up... 03:42:54 INFO - Return code: 0 03:42:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:42:54 INFO - Using env: {'DISPLAY': ':0', 03:42:54 INFO - 'HOME': '/home/cltbld', 03:42:54 INFO - 'LANG': 'en_US.UTF-8', 03:42:54 INFO - 'LANGUAGE': 'en_US:en', 03:42:54 INFO - 'LOGNAME': 'cltbld', 03:42:54 INFO - 'MAIL': '/var/mail/cltbld', 03:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:54 INFO - 'MOZ_NO_REMOTE': '1', 03:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:54 INFO - 'NO_EM_RESTART': '1', 03:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:54 INFO - 'PWD': '/builds/slave/test', 03:42:54 INFO - 'SHELL': '/bin/bash', 03:42:54 INFO - 'SHLVL': '1', 03:42:54 INFO - 'TERM': 'linux', 03:42:54 INFO - 'TMOUT': '86400', 03:42:54 INFO - 'USER': 'cltbld', 03:42:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:54 INFO - '_': '/tools/buildbot/bin/python'} 03:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:55 INFO - Downloading/unpacking psutil>=3.1.1 03:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:56 INFO - Installing collected packages: psutil 03:42:56 INFO - Running setup.py install for psutil 03:42:56 INFO - building 'psutil._psutil_linux' extension 03:42:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:42:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:42:58 INFO - building 'psutil._psutil_posix' extension 03:42:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:42:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:42:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:58 INFO - Successfully installed psutil 03:42:58 INFO - Cleaning up... 03:42:58 INFO - Return code: 0 03:42:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:42:58 INFO - Using env: {'DISPLAY': ':0', 03:42:58 INFO - 'HOME': '/home/cltbld', 03:42:58 INFO - 'LANG': 'en_US.UTF-8', 03:42:58 INFO - 'LANGUAGE': 'en_US:en', 03:42:58 INFO - 'LOGNAME': 'cltbld', 03:42:58 INFO - 'MAIL': '/var/mail/cltbld', 03:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:58 INFO - 'MOZ_NO_REMOTE': '1', 03:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:58 INFO - 'NO_EM_RESTART': '1', 03:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:58 INFO - 'PWD': '/builds/slave/test', 03:42:58 INFO - 'SHELL': '/bin/bash', 03:42:58 INFO - 'SHLVL': '1', 03:42:58 INFO - 'TERM': 'linux', 03:42:58 INFO - 'TMOUT': '86400', 03:42:58 INFO - 'USER': 'cltbld', 03:42:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:58 INFO - '_': '/tools/buildbot/bin/python'} 03:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42: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 03:42: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 03:42: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 03:42: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 03:42:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:00 INFO - Installing collected packages: mozsystemmonitor 03:43:00 INFO - Running setup.py install for mozsystemmonitor 03:43:00 INFO - Successfully installed mozsystemmonitor 03:43:00 INFO - Cleaning up... 03:43:00 INFO - Return code: 0 03:43:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:00 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 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:43:00 INFO - Using env: {'DISPLAY': ':0', 03:43:00 INFO - 'HOME': '/home/cltbld', 03:43:00 INFO - 'LANG': 'en_US.UTF-8', 03:43:00 INFO - 'LANGUAGE': 'en_US:en', 03:43:00 INFO - 'LOGNAME': 'cltbld', 03:43:00 INFO - 'MAIL': '/var/mail/cltbld', 03:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:00 INFO - 'MOZ_NO_REMOTE': '1', 03:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:00 INFO - 'NO_EM_RESTART': '1', 03:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:00 INFO - 'PWD': '/builds/slave/test', 03:43:00 INFO - 'SHELL': '/bin/bash', 03:43:00 INFO - 'SHLVL': '1', 03:43:00 INFO - 'TERM': 'linux', 03:43:00 INFO - 'TMOUT': '86400', 03:43:00 INFO - 'USER': 'cltbld', 03:43:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:00 INFO - '_': '/tools/buildbot/bin/python'} 03:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:43: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 03:43: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 03:43: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 03:43: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 03:43:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:01 INFO - warning: no files found matching '*.txt' 03:43:01 INFO - no previously-included directories found matching 'build' 03:43:01 INFO - no previously-included directories found matching 'dist' 03:43:01 INFO - no previously-included directories found matching '.git*' 03:43:01 INFO - Installing collected packages: jsonschema, functools32 03:43:01 INFO - Running setup.py install for functools32 03:43:01 INFO - warning: no files found matching '*.txt' 03:43:01 INFO - no previously-included directories found matching 'build' 03:43:01 INFO - no previously-included directories found matching 'dist' 03:43:01 INFO - no previously-included directories found matching '.git*' 03:43:01 INFO - Successfully installed jsonschema functools32 03:43:01 INFO - Cleaning up... 03:43:01 INFO - Return code: 0 03:43:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:43:01 INFO - Using env: {'DISPLAY': ':0', 03:43:01 INFO - 'HOME': '/home/cltbld', 03:43:01 INFO - 'LANG': 'en_US.UTF-8', 03:43:01 INFO - 'LANGUAGE': 'en_US:en', 03:43:01 INFO - 'LOGNAME': 'cltbld', 03:43:01 INFO - 'MAIL': '/var/mail/cltbld', 03:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:01 INFO - 'MOZ_NO_REMOTE': '1', 03:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:01 INFO - 'NO_EM_RESTART': '1', 03:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:01 INFO - 'PWD': '/builds/slave/test', 03:43:01 INFO - 'SHELL': '/bin/bash', 03:43:01 INFO - 'SHLVL': '1', 03:43:01 INFO - 'TERM': 'linux', 03:43:01 INFO - 'TMOUT': '86400', 03:43:01 INFO - 'USER': 'cltbld', 03:43:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:01 INFO - '_': '/tools/buildbot/bin/python'} 03:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:43:02 INFO - Cleaning up... 03:43:02 INFO - Return code: 0 03:43:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:02 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 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:43:02 INFO - Using env: {'DISPLAY': ':0', 03:43:02 INFO - 'HOME': '/home/cltbld', 03:43:02 INFO - 'LANG': 'en_US.UTF-8', 03:43:02 INFO - 'LANGUAGE': 'en_US:en', 03:43:02 INFO - 'LOGNAME': 'cltbld', 03:43:02 INFO - 'MAIL': '/var/mail/cltbld', 03:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:02 INFO - 'MOZ_NO_REMOTE': '1', 03:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:02 INFO - 'NO_EM_RESTART': '1', 03:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:02 INFO - 'PWD': '/builds/slave/test', 03:43:02 INFO - 'SHELL': '/bin/bash', 03:43:02 INFO - 'SHLVL': '1', 03:43:02 INFO - 'TERM': 'linux', 03:43:02 INFO - 'TMOUT': '86400', 03:43:02 INFO - 'USER': 'cltbld', 03:43:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:02 INFO - '_': '/tools/buildbot/bin/python'} 03:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:03 INFO - Downloading docopt-0.6.1.tar.gz 03:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:04 INFO - Running setup.py install for blobuploader 03:43:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:04 INFO - Running setup.py install for requests 03:43:04 INFO - Running setup.py install for docopt 03:43:04 INFO - Successfully installed blobuploader requests docopt 03:43:04 INFO - Cleaning up... 03:43:04 INFO - Return code: 0 03:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:04 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 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:04 INFO - Using env: {'DISPLAY': ':0', 03:43:04 INFO - 'HOME': '/home/cltbld', 03:43:04 INFO - 'LANG': 'en_US.UTF-8', 03:43:04 INFO - 'LANGUAGE': 'en_US:en', 03:43:04 INFO - 'LOGNAME': 'cltbld', 03:43:04 INFO - 'MAIL': '/var/mail/cltbld', 03:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:04 INFO - 'MOZ_NO_REMOTE': '1', 03:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:04 INFO - 'NO_EM_RESTART': '1', 03:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:04 INFO - 'PWD': '/builds/slave/test', 03:43:04 INFO - 'SHELL': '/bin/bash', 03:43:04 INFO - 'SHLVL': '1', 03:43:04 INFO - 'TERM': 'linux', 03:43:04 INFO - 'TMOUT': '86400', 03:43:04 INFO - 'USER': 'cltbld', 03:43:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:04 INFO - '_': '/tools/buildbot/bin/python'} 03:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:04 INFO - Running setup.py (path:/tmp/pip-HE80Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:04 INFO - Running setup.py (path:/tmp/pip-0cuSQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:04 INFO - Running setup.py (path:/tmp/pip-zOMo53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:05 INFO - Running setup.py (path:/tmp/pip-tGbFql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:05 INFO - Running setup.py (path:/tmp/pip-tEAGyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:05 INFO - Running setup.py (path:/tmp/pip-dO56jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:05 INFO - Running setup.py (path:/tmp/pip-uYrW7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:05 INFO - Running setup.py (path:/tmp/pip-0WT1ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:05 INFO - Running setup.py (path:/tmp/pip-GhIJV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:05 INFO - Running setup.py (path:/tmp/pip-mULyuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:05 INFO - Running setup.py (path:/tmp/pip-iOfKAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:05 INFO - Running setup.py (path:/tmp/pip-RbLEFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:05 INFO - Running setup.py (path:/tmp/pip-FjaV1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:05 INFO - Running setup.py (path:/tmp/pip-wz5PMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:05 INFO - Running setup.py (path:/tmp/pip-JGVytY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:05 INFO - Running setup.py (path:/tmp/pip-6uj4Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:05 INFO - Running setup.py (path:/tmp/pip-elcWAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:05 INFO - Running setup.py install for manifestparser 03:43:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Running setup.py install for mozcrash 03:43:06 INFO - Running setup.py install for mozdebug 03:43:06 INFO - Running setup.py install for mozdevice 03:43:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Running setup.py install for mozfile 03:43:06 INFO - Running setup.py install for mozhttpd 03:43:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Running setup.py install for mozinfo 03:43:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Running setup.py install for mozInstall 03:43:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:06 INFO - Running setup.py install for mozleak 03:43:06 INFO - Running setup.py install for mozlog 03:43:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Running setup.py install for moznetwork 03:43:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Running setup.py install for mozprocess 03:43:07 INFO - Running setup.py install for mozprofile 03:43:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Running setup.py install for mozrunner 03:43:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Running setup.py install for mozscreenshot 03:43:07 INFO - Running setup.py install for moztest 03:43:07 INFO - Running setup.py install for mozversion 03:43:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:07 INFO - Cleaning up... 03:43:07 INFO - Return code: 0 03:43:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:07 INFO - Using env: {'DISPLAY': ':0', 03:43:07 INFO - 'HOME': '/home/cltbld', 03:43:07 INFO - 'LANG': 'en_US.UTF-8', 03:43:07 INFO - 'LANGUAGE': 'en_US:en', 03:43:07 INFO - 'LOGNAME': 'cltbld', 03:43:07 INFO - 'MAIL': '/var/mail/cltbld', 03:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:07 INFO - 'MOZ_NO_REMOTE': '1', 03:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:07 INFO - 'NO_EM_RESTART': '1', 03:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:07 INFO - 'PWD': '/builds/slave/test', 03:43:07 INFO - 'SHELL': '/bin/bash', 03:43:07 INFO - 'SHLVL': '1', 03:43:07 INFO - 'TERM': 'linux', 03:43:07 INFO - 'TMOUT': '86400', 03:43:07 INFO - 'USER': 'cltbld', 03:43:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:07 INFO - '_': '/tools/buildbot/bin/python'} 03:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:07 INFO - Running setup.py (path:/tmp/pip-FQlZBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:08 INFO - Running setup.py (path:/tmp/pip-UvM8c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:08 INFO - Running setup.py (path:/tmp/pip-vMAgLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:08 INFO - Running setup.py (path:/tmp/pip-DR4rII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:08 INFO - Running setup.py (path:/tmp/pip-PJghUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:08 INFO - Running setup.py (path:/tmp/pip-QkiOKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:08 INFO - Running setup.py (path:/tmp/pip-KYojlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:08 INFO - Running setup.py (path:/tmp/pip-USnDMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:08 INFO - Running setup.py (path:/tmp/pip-kbXne9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:08 INFO - Running setup.py (path:/tmp/pip-V3Phwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:08 INFO - Running setup.py (path:/tmp/pip-8Wmwcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:08 INFO - Running setup.py (path:/tmp/pip-1fzxBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:08 INFO - Running setup.py (path:/tmp/pip-Oksxri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:08 INFO - Running setup.py (path:/tmp/pip-Yaz2oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:08 INFO - Running setup.py (path:/tmp/pip-6B_pWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:09 INFO - Running setup.py (path:/tmp/pip-0gUZWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:09 INFO - Running setup.py (path:/tmp/pip-aivOF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:43:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:10 INFO - Downloading blessings-1.6.tar.gz 03:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:43:10 INFO - Installing collected packages: blessings 03:43:10 INFO - Running setup.py install for blessings 03:43:10 INFO - Successfully installed blessings 03:43:10 INFO - Cleaning up... 03:43:10 INFO - Return code: 0 03:43:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:43:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:10 INFO - Reading from file tmpfile_stdout 03:43:10 INFO - Current package versions: 03:43:10 INFO - argparse == 1.2.1 03:43:10 INFO - blessings == 1.6 03:43:10 INFO - blobuploader == 1.2.4 03:43:10 INFO - docopt == 0.6.1 03:43:10 INFO - functools32 == 3.2.3-2 03:43:10 INFO - jsonschema == 2.5.1 03:43:10 INFO - manifestparser == 1.1 03:43:10 INFO - mozInstall == 1.13 03:43:10 INFO - mozcrash == 1.0 03:43:10 INFO - mozdebug == 0.1 03:43:10 INFO - mozdevice == 0.51 03:43:10 INFO - mozfile == 1.2 03:43:10 INFO - mozhttpd == 0.7 03:43:10 INFO - mozinfo == 0.10 03:43:10 INFO - mozleak == 0.1 03:43:10 INFO - mozlog == 3.5 03:43:10 INFO - moznetwork == 0.27 03:43:10 INFO - mozprocess == 0.25 03:43:10 INFO - mozprofile == 0.28 03:43:10 INFO - mozrunner == 6.13 03:43:10 INFO - mozscreenshot == 0.1 03:43:10 INFO - mozsystemmonitor == 0.3 03:43:10 INFO - moztest == 0.8 03:43:10 INFO - mozversion == 1.4 03:43:10 INFO - psutil == 3.1.1 03:43:10 INFO - requests == 1.2.3 03:43:10 INFO - wsgiref == 0.1.2 03:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43: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')]} 03:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:10 INFO - Using env: {'DISPLAY': ':0', 03:43:10 INFO - 'HOME': '/home/cltbld', 03:43:10 INFO - 'LANG': 'en_US.UTF-8', 03:43:10 INFO - 'LANGUAGE': 'en_US:en', 03:43:10 INFO - 'LOGNAME': 'cltbld', 03:43:10 INFO - 'MAIL': '/var/mail/cltbld', 03:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:10 INFO - 'MOZ_NO_REMOTE': '1', 03:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:10 INFO - 'NO_EM_RESTART': '1', 03:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:10 INFO - 'PWD': '/builds/slave/test', 03:43:10 INFO - 'SHELL': '/bin/bash', 03:43:10 INFO - 'SHLVL': '1', 03:43:10 INFO - 'TERM': 'linux', 03:43:10 INFO - 'TMOUT': '86400', 03:43:10 INFO - 'USER': 'cltbld', 03:43:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:10 INFO - '_': '/tools/buildbot/bin/python'} 03:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:43:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:43:12 INFO - Installing collected packages: simplejson 03:43:12 INFO - Running setup.py install for simplejson 03:43:12 INFO - building 'simplejson._speedups' extension 03:43:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:43:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:43:13 INFO - Successfully installed simplejson 03:43:13 INFO - Cleaning up... 03:43:13 INFO - Return code: 0 03:43:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29219c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, '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-1507014692.838275-1376920695', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:43:13 INFO - Using env: {'DISPLAY': ':0', 03:43:13 INFO - 'HOME': '/home/cltbld', 03:43:13 INFO - 'LANG': 'en_US.UTF-8', 03:43:13 INFO - 'LANGUAGE': 'en_US:en', 03:43:13 INFO - 'LOGNAME': 'cltbld', 03:43:13 INFO - 'MAIL': '/var/mail/cltbld', 03:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:13 INFO - 'MOZ_NO_REMOTE': '1', 03:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:13 INFO - 'NO_EM_RESTART': '1', 03:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:13 INFO - 'PWD': '/builds/slave/test', 03:43:13 INFO - 'SHELL': '/bin/bash', 03:43:13 INFO - 'SHLVL': '1', 03:43:13 INFO - 'TERM': 'linux', 03:43:13 INFO - 'TMOUT': '86400', 03:43:13 INFO - 'USER': 'cltbld', 03:43:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:13 INFO - '_': '/tools/buildbot/bin/python'} 03:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:43:13 INFO - Cleaning up... 03:43:13 INFO - Return code: 0 03:43:13 INFO - Running post-action listener: _resource_record_post_action 03:43:13 INFO - Running post-action listener: _start_resource_monitoring 03:43:13 INFO - Starting resource monitoring. 03:43:13 INFO - [mozharness: 2017-10-03 10:43:13.503894Z] Finished create-virtualenv step (success) 03:43:13 INFO - [mozharness: 2017-10-03 10:43:13.504923Z] Running install step. 03:43:13 INFO - Running pre-action listener: _resource_record_pre_action 03:43:13 INFO - Running main action method: install 03:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:13 INFO - Reading from file tmpfile_stdout 03:43:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:43:13 INFO - Reading from file tmpfile_stdout 03:43:13 INFO - Output received: 03:43:13 INFO - Usage: mozinstall [options] installer 03:43:13 INFO - Options: 03:43:13 INFO - -h, --help show this help message and exit 03:43:13 INFO - -d DEST, --destination=DEST 03:43:13 INFO - Directory to install application into. [default: 03:43:13 INFO - "/builds/slave/test"] 03:43:13 INFO - --app=APP Application being installed. [default: firefox] 03:43:13 INFO - mkdir: /builds/slave/test/build/application 03:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:43:31 INFO - Reading from file tmpfile_stdout 03:43:31 INFO - Output received: 03:43:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:43:31 INFO - Running post-action listener: _resource_record_post_action 03:43:31 INFO - [mozharness: 2017-10-03 10:43:31.658501Z] Finished install step (success) 03:43:31 INFO - [mozharness: 2017-10-03 10:43:31.658756Z] Running setup-mitmproxy step. 03:43:31 INFO - Running pre-action listener: _resource_record_pre_action 03:43:31 INFO - Running main action method: setup_mitmproxy 03:43:31 INFO - Skipping: mitmproxy is not required 03:43:31 INFO - Running post-action listener: _resource_record_post_action 03:43:31 INFO - [mozharness: 2017-10-03 10:43:31.659888Z] Finished setup-mitmproxy step (success) 03:43:31 INFO - [mozharness: 2017-10-03 10:43:31.660125Z] Running run-tests step. 03:43:31 INFO - Running pre-action listener: _resource_record_pre_action 03:43:31 INFO - Running pre-action listener: _set_gcov_prefix 03:43:31 INFO - Running main action method: run_tests 03:43:31 WARNING - Try message not found. 03:43:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:43:31 INFO - Python 2.7.3 03:43:31 INFO - Return code: 0 03:43:31 INFO - grabbing minidump binary from tooltool 03:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:31 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 0x291ed60>, '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 0x291fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:43:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:43:31 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:43:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:43:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:43:31 INFO - Return code: 0 03:43:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:43:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:43:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:43:31 INFO - ENV: RUST_BACKTRACE is now full 03:43:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:43:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:43:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:43:31 INFO - Using env: {'DISPLAY': ':0', 03:43:31 INFO - 'HOME': '/home/cltbld', 03:43:31 INFO - 'LANG': 'en_US.UTF-8', 03:43:31 INFO - 'LANGUAGE': 'en_US:en', 03:43:31 INFO - 'LOGNAME': 'cltbld', 03:43:31 INFO - 'MAIL': '/var/mail/cltbld', 03:43:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:43:31 INFO - 'MOZ_ACCELERATED': '1', 03:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:31 INFO - 'MOZ_NO_REMOTE': '1', 03:43:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:31 INFO - 'MOZ_WEBRENDER': '1', 03:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:31 INFO - 'NO_EM_RESTART': '1', 03:43:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:31 INFO - 'PWD': '/builds/slave/test', 03:43:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:31 INFO - 'RUST_BACKTRACE': 'full', 03:43:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:43:31 INFO - 'SHELL': '/bin/bash', 03:43:31 INFO - 'SHLVL': '1', 03:43:31 INFO - 'TERM': 'linux', 03:43:31 INFO - 'TMOUT': '86400', 03:43:31 INFO - 'USER': 'cltbld', 03:43:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:31 INFO - '_': '/tools/buildbot/bin/python'} 03:43:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:43:32 INFO - mozversion application_buildid: 20171003094409 03:43:32 INFO - mozversion application_changeset: 11fe0a2895aab26c57bcfe61b3041d7837e954cd 03:43:32 INFO - mozversion application_display_name: Nightly 03:43:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:43:32 INFO - mozversion application_name: Firefox 03:43:32 INFO - mozversion application_remotingname: firefox 03:43:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:43:32 INFO - mozversion application_vendor: Mozilla 03:43:32 INFO - mozversion application_version: 58.0a1 03:43:32 INFO - mozversion platform_buildid: 20171003094409 03:43:32 INFO - mozversion platform_changeset: 11fe0a2895aab26c57bcfe61b3041d7837e954cd 03:43:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:43:32 INFO - mozversion platform_version: 58.0a1 03:43:32 INFO - using testdate: 1507027412 03:43:32 INFO - actual date: 1507027412 03:43:32 INFO - starting webserver on 'localhost:40594' 03:43:32 INFO - SUITE-START | Running 2 tests 03:43:32 INFO - TEST-START | dromaeo_css 03:43:32 INFO - Initialising browser for dromaeo_css test... 03:43:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40594/getInfo.html -profile /tmp/tmpL5jTQj/profile 03:43:32 INFO - TEST-INFO | started process 3882 (/builds/slave/test/build/application/firefox/firefox http://localhost:40594/getInfo.html) 03:43:42 INFO - TEST-INFO | 3882: exit 0 03:43:42 INFO - Browser initialized. 03:43:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:43:42 INFO - Using env: {'DISPLAY': ':0', 03:43:42 INFO - 'HOME': '/home/cltbld', 03:43:42 INFO - 'JSGC_DISABLE_POISONING': '1', 03:43:42 INFO - 'LANG': 'en_US.UTF-8', 03:43:42 INFO - 'LANGUAGE': 'en_US:en', 03:43:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:43:42 INFO - 'LOGNAME': 'cltbld', 03:43:42 INFO - 'MAIL': '/var/mail/cltbld', 03:43:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:43:42 INFO - 'MOZ_ACCELERATED': '1', 03:43:42 INFO - 'MOZ_CRASHREPORTER': '1', 03:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:43:42 INFO - 'MOZ_NO_REMOTE': '1', 03:43:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:42 INFO - 'MOZ_WEBRENDER': '1', 03:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:42 INFO - 'NO_EM_RESTART': '1', 03:43:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:42 INFO - 'PWD': '/builds/slave/test', 03:43:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:42 INFO - 'RUST_BACKTRACE': 'full', 03:43:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:43:42 INFO - 'SHELL': '/bin/bash', 03:43:42 INFO - 'SHLVL': '1', 03:43:42 INFO - 'TERM': 'linux', 03:43:42 INFO - 'TMOUT': '86400', 03:43:42 INFO - 'USER': 'cltbld', 03:43:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 03:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:42 INFO - '_': '/tools/buildbot/bin/python'} 03:43:42 INFO - TEST-INFO | started process 4129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5jTQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:43 INFO - PID 4129 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:43:43 INFO - PID 4129 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:43:43 INFO - PID 4129 | 03:43:43 INFO - PID 4129 | (/builds/slave/test/build/application/firefox/firefox:4187): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:43:43 INFO - PID 4129 | 03:43:54 INFO - PID 4129 | RSS: Main: 214175744 03:43:54 INFO - PID 4129 | 03:46:50 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40594/tests/dromaeo/cssquery-ext.html) 03:46:52 INFO - PID 4129 | RSS: Main: 206262272 03:46:52 INFO - PID 4129 | 03:49:55 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-ext.html (next: http://localhost:40594/tests/dromaeo/cssquery-jquery.html) 03:49:55 INFO - PID 4129 | RSS: Main: 205533184 03:49:55 INFO - PID 4129 | 03:52:57 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40594/tests/dromaeo/cssquery-mootools.html) 03:52:58 INFO - PID 4129 | RSS: Main: 206315520 03:52:58 INFO - PID 4129 | 03:56:00 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40594/tests/dromaeo/cssquery-prototype.html) 03:56:01 INFO - PID 4129 | RSS: Main: 206651392 03:56:01 INFO - PID 4129 | 03:59:04 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40594/tests/dromaeo/cssquery-yui.html) 03:59:05 INFO - PID 4129 | RSS: Main: 209477632 03:59:05 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | Cycle 1(1): loaded http://localhost:40594/tests/dromaeo/cssquery-yui.html (next: http://localhost:40594/tests/dromaeo/cssquery-dojo.html) 04:02:07 INFO - PID 4129 | RSS: Main: 209502208 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | __start_tp_report 04:02:07 INFO - PID 4129 | _x_x_mozilla_page_load 04:02:07 INFO - PID 4129 | _x_x_mozilla_page_load_details 04:02:07 INFO - PID 4129 | |i|pagename|runs| 04:02:07 INFO - PID 4129 | |0;dojo.html;3100.8759649614003;3127.0306205076427;3139.733122684571;3150.070729134905;3158.510430883211;6182.598131121474;6214;6238.189035425394;6250.499960003201;6306.842328941779;6178.227721534809;6180.598261113036;6183.628982261056;6228.470580000694;6252.093446450262;5633.070543360361;5690.06113991191;5795.840831833629;5806.158107074471;5826.6212696174825;5663.971680141593;5777.45114214149;5797.333306669745;5802.274715660543;5849.619774714652;5567.4432556744205;5625.774969001235;5652.63257888236;5653.123765816305;5655.943440565604;5666.348369937427;5708.172315014342;5759;5777.277840269966;5784.623999440065;5625;5672.546196304285;5733.942660573424;5741.569382296345;5772.769089236425;6111.602745821552;6155.415235552616;6171.105189747506;6240.781572644935;6282.340354262828;6566.310537393552;6625.900611490832;6648.534602577822;6649.4347980421235;6662.700178491979;6750.797476075725;6840.11078559789;6841.589504629738;6859.382655560974;6875.106236189314;6190.690465476753;6204.720787564571;6234.18955535782;6328.715207815613;6332.810015699536;6847.554908930903;6903.1716194057035;6987.021816945632;6997.055397521372;6998.510104292651;6389.872202555923;6553.639549824806;6554.754596626625;6579.835504112435;6598.307177746267;6597.406233439014;6634.436072933855;6720.630365329856;6802.285759995229;6826.453883689393;6696.029075783984;6702.430293425016;6704.497162712719;6723.865522689519;6731.764388246388;6554.279029306773;6658.1011563438315;6693.029510720919;6743.9325606743305;6756.358145976124;4820.903581928342;4846.224604063404;4888.7311197884455;4945.406551213805;4948.703077815343;4233.153369326147;4237.427947227146;4252.85115020979;4283.464566929134;4287.549807270192;5746.511546518509;5749.741261643152;5811.767529298865;5814.534837213013;5817.069268916953;6676.499262555328;6685.79942601713;6745.763898263537;6748.662566871637;6764.526483146231;5706.686132262766;5712.971435142797;5769.68266745333;5773.913391299134;5794.88410231793;5641.774329026793;5672.7730890763905;5690.3456102548735;5698.1737648041635;5711.628744131618;6474.611523308617;6508.381703738138;6524.445422139172;6529.510286728514;6535.8366040848405;6668;6802.97955306708;6810.182778066664;6819.727210911508;6830.5218634697085;6549.901751473636;6550.672466376757;6570.868582628416;6592.604443733391;6593.142891424084;6682.031105489774;6696.229933557508;6710.463162946855;6777.491688123509;6788.117544719353;6565.048068030204;6579.342065793382;6592.934070659232;6596.3073877244115;6648.90026649591;6420.839479013062;6449.935500644933;6460.12788273577;6467.320931302145;6470.967645161744;6323.304436511888;6425.614463132227;6430.64631445275;6438.195225596801;6440.0983862260255;5795.652260864362;6318.020706790455;6350.269718982377;6393.968030160006;6394.328595497405;6536.575122617015;6599;6614.206295244409;6661.933380666132;6664.666766661744;6309.49524038085;6380.425761681471;6381.266154392304;6427.550071495138;6441.613503189824 04:02:07 INFO - PID 4129 | |1;ext.html;850.6214734443172;867.8481265778487;871.1854416120927;875.2953872132938;876.2114097312418;39309.60690393095;43333.566664333346;43434.78282608582;43487;43539.911502212424;38263.80868095656;39001;39111.80444097782;39137.804310978405;39251;7073.080499535066;7233.276672332777;7247.420206383503;7846.136924938252;7979.880301795478;7877.369810415153;7929.444938854283;7962.52224866507;7977.162397948219;8014.599270036504;7969.521828690268;7994.840103197933;8003.759887203393;8022.1576734442915;8095.7166499172545;7888.368930485547;8031.076426210973;8038;8055.718049868285;8058.798530036796;7909.24862138096;7909.644066017043;7917.7624671259955;7971.242731940456;7977.760667179994;38680.61319386798;38996.80501597502;39046.41430378547;39121.21757564861;39147;3494.353544594258;3525.5240542526685;3540.327337805809;3541.8052007139595;3544.025393016941;31816.681833181603;31852.36295274105;32078;32142.678573214434;32175.19562010945;5113.795448182068;5165.793368265265;5182.740862956837;5191;5267.815626453055;206246;206363;207058;207091;208502;43403.34894976578;49772.50227497751;50365.74817125891;50494;50510.74744626253;45804.541954580694;45828.3125753114;51292.74353628208;51456.74271628618;51716;15354.616134596501;15506.767398489032;15557.688846223238;15559.144247066293;15578.688426231412;12624.431900564497;12712.872871271355;12724.745505089846;12730.554430594884;12756.681082972815;13268.469261229635;13743.450261989408;13769.655758605915;13776.655583610289;13904.374303156383;5502.8349149525575;5569.66582005081;5580.19087232349;5589.329280486368;5685.800996965169;1012.336919317848;1014.761531040205;1018.7860549284733;1024.4519182237616;1025.4257615735212;23272.534549309257;23400.06399744025;23478;23554.7644523556;23641.408964775674;1120.506976930148;1137.351709525579;1137.9089672826153;1144.4792619358172;1147.3460127727114;12393;12435.502579896884;12438.564650237198;12470.43883025266;12618.495260189673;236519;236932;237230;238822;240326;54034.7298263514;54113.45886541163;54292;54345.456545434834;54481.1827822583;1423.992880035593;1476.1733429279639;1479.4452080469823;1483.3325003748357;1488.6352843553398;22644.886775566676;23386.53226935418;23605.52788944246;23789.762102378754;24019.879900601085;34915.4762678555;34964.12589685278;35065.64934350624;35153.296934061684;35234.8238258807;196453;197307;198194;198231;198991;31668.524972124975;32000.5199922006;33039;33938.321233574694;34510;43606;44340.33489497595;44588;44903.32645010262;45214.77392613148;31609;32351.838240808644;32510;32645;32703;31360.843195783877;31448.213794655316;31858.840705796323;32092.679073209903;32281.838590807834;36443.817780910926;36610.26779464449;36620.45069323909;36781.26437471182;37059.62940370562;31100.066997990096;31380;31488.84255578799;31656.36687266288;31989.36021279515;23210.1876434324;23831.523369532166;24261.27216183517;24372.51254974855;24647.876760616084 04:02:07 INFO - PID 4129 | |2;jquery.html;582.1413415212562;585.8828234353127;587.944145306196;596.5317225977607;599.6731781179262;22557.210497632586;23269.301920942376;23294.18470353538;23435.179768708098;23498.76501234987;21368.57262854742;21720.34838954834;23010.539789204206;25903;25989.740102599015;6535.901961470569;6732.259451460335;6738.898916516257;6739.09022281993;6739.797806065826;6661.566998145105;6750.56121352113;6753.561018533805;6763.763268285611;6773.593584384953;6051.092336149569;6578.276389597165;6584.604923704569;6598.109255250528;6654.933450665504;6600.6699665016795;6620.172478440195;6672.299408562079;6673.966630166842;6673.966630166867;5856.32652244993;6147.692615369258;6209.410106039919;6218.595791273553;6237.313895471494;29504.557431638543;30173.396532069237;30200.18798872053;30208.54687179694;30309.24226894323;2022.049636670777;2030.3401394546831;2034.338839877046;2052.989735051315;2058.053295484079;19629.50926226856;19643.705344419846;19739.40781776549;19787.30744423938;19947.90026049875;2445.9388515287083;2518.4837108392735;2518.5718427867123;2520.206135067448;2522.1424715596786;118692.40653796762;122838.38580807128;122839;148702;154252;20351.25258090139;21370.78629213719;22244.666330005064;22404.31148262219;22927.426814329443;24139.275821725376;44254;44653.77673111614;44816;45060;10353.378797272037;10433.373997560171;10461.163106951426;10463.476826158661;10627.14982801374;9406.247500199968;9509.381890177116;9586.904130958601;9618.134367906781;9745.902540974641;9089.545522723838;9281;9379.953100234456;9450.243980481546;9653.855192172123;2642.907498237591;2649.496595646821;2798.3423895384567;2805.2689922403156;2819.1119797264205;956.4691596164196;982.268210183418;985.571276494727;988.4958671077802;995.5022488755623;20216.09027593762;20388.898055509922;20511.17955281802;20536.897315513626;20623.8968805158;1032.0659802878406;1038.4288641247283;1041.729150420896;1047.6490375724218;1064.505005172583;10983;11100.167487438475;11188.160887933274;11282.94358528202;11406.714832129097;447634.5236547593;474215;474358;475267;496079;121259.39370303092;121492.39253803674;122345.38827305984;122596.38701806434;123788;1162.0877611075266;1178;1189.3280296632374;1205.2045649871043;1208.1663652080038;18305.725414119064;18418.447446576625;18623.44129676058;18798;18914.905425473335;53808.46191538034;54665.72667136639;57122.71438642946;57415;58901.705491473986;71146;71279;71587.28412715805;73289.6335518319;74020;15333.463328783439;15339.156346401054;15394.230288485754;15545;15659.451919182773;23827.642585360885;23830.761692382854;23871.164509242095;24129.276121716375;24217.63673544863;18721.719174212125;18843.434696959113;19143.329983450512;19223.51941201481;19251.807481925003;16632.75050874262;16793.41223057187;16981.658692185305;17127.91436042812;17470.47588572345;18713.625727485647;19163.71254431157;19222.327218547285;19251.1336989833;19351.90324048427;15133.243337832844;15170.924145379202;15239.923800380928;15247.313870875616;15277.465288714842;18468.907655461637;18571.535711607317;18634.72047919255;18830.905845470686;18947.43157705271 04:02:07 INFO - PID 4129 | |3;mootools.html;1320.8414990201177;1382.730367578322;1394.9790753138711;1405.2271250812057;1415.7239338329023;14214.502492412756;14566.490172843953;14701.632459188526;14770.85229147707;14898;14354.641133971656;14387.78418323726;14475.493357732481;14565;14605.634859128528;2730.959035614467;2767.5433553463704;2811.3955499567587;2828.9532872836976;2831.730985556369;2658.215826331227;2761.2130542795308;2763.7236276372405;2763.875625596843;2769.556870900656;2343.9296821095395;2497.8751062446895;2503.236512863576;2719.1434698070143;2756.1180422264883;2753.1190019193864;2770.8476033818133;2774.569941659046;2775.4449110177943;2781.5549512078073;2543.0082267915527;2553.7318581549043;2555.540002799495;2580.251726999168;2587.223832850156;15015.399384024735;15443.382264709398;15577.844221557752;15616.063036217864;15640.843591564166;8147.388945829087;8424.368172387034;8453.239208471206;8489;8519.318454523685;5176.715280659562;5306.522412982811;5341.385740639837;5429.891402171974;5708.77164913403;1972.0731256309512;1998.2706312195944;2010.2963962613114;2044.2334124703236;2048.7131801547794;27674.308142296402;27887.86056069727;27913.441731165465;27945.86027069872;27984.720152798414;7285.125784905846;7305.159906610702;7352.926470735224;7394.223606521346;7459;20477.283295084897;20671.483212919797;20697;20709.896450517652;20773.68839467379;8412.957935210285;8477.74566762998;8482.066972633005;8485.872711909326;8493.745187644381;7204.207537170907;7559;7560.659770310349;7610.657520411595;7641.808954776175;5444.618876678674;5681.176229446707;5734.569907256972;5759.798407055733;5813.505852002542;1699.2608215426328;1741.172942852135;1774.8225177482148;1781.5278951077976;1789.185920406212;867.3624885708999;870.4211699219948;903.7830920579145;910.9908900911039;917.2295271971443;8293.875591866126;8328.417010809186;8391;8397.580120994047;8533.615987280587;975.5268694683073;997.0627610046533;998.5207100591612;999.6401295533602;1005.5826831864695;4613;4624.676272660881;4765.332853400527;4790.449098353734;4818.95181048185;21523.461913452287;22446.32661020172;22546;22614;22771;20744.79255207459;21918.45203869916;22195.778042219696;22327.218547350763;22695.773042269368;11384.943075284571;11515.136364772508;11707.239029463057;11783.175177737647;11828.467718952668;7921.1682773307975;7942.245486678757;7959.323457505945;7999.400044996765;8044.839103217786;18326.358577449726;18835.529111772314;19234.326798561982;19367.3221437249;19586.60826783428;19343.226270949006;19968.90015549913;20222.79777202209;20313.187472501526;20558.691619626017;10736.30214036085;11058.778824423627;11169.553217871195;11242.66272011841;11322.433878306216;13423.328833558087;13680.65798355049;13723.519676811264;13748.381322840696;13780;11182.161337899528;11268.830967535658;11303.491342889425;11409.429528523375;11534.423278836193;10945.726356841144;11078.667639970814;11094.889051109709;11152.88847111551;11389.601363952223;10111.544980476043;10217.23370747182;10238.12975897057;10238.436885971343;10249.026342497451;7376.7049318026675;7464;7551.73568925085;7567.167611562613;7568.091828980338;7302.744403945836;7367.742129025459;7414.147373052168;7416.7404140854815;7472.40220782347 04:02:07 INFO - PID 4129 | |4;prototype.html;499.9025190087932;506.99239511407313;528.53184502973;537.5914305128101;540.6864018869056;6083.847903802402;6103.664298463583;6103.969480152604;6115.41903519166;6164.537659675526;6051.697415129237;6074.696265186745;6087.817365479032;6102.786402475915;6155.938440615592;5066.949330506703;5068.619853510983;5101.617378696594;5113.411957624883;5126.974365128169;5005.349304590398;5042.47054059324;5067.391912970449;5071.264666623338;5084.694918304895;4740.90518189636;4845.37010188675;4852.733099679516;4889.755512224392;5002.799328161252;4841.782119804618;4883.755812209375;4886.560209581155;4921.138800709898;4925.359703238574;4384.495782984965;4409.118176364708;4429.114177164548;4436;4450.777461126931;5728.8854222915725;5884.911726324066;5901.2918449785875;5903.852403689899;6001.129836173774;5533.418991005927;5552.555795536387;5560.36055853578;5593.440655934414;5598.188262701886;6301.179597607834;6337.904931426032;6352.745890164388;6375.661111166614;6418.775342862978;4485.192665320241;4671.11248862715;4716.3632909557455;4746.952530474686;4791.113643975876;6408.455281301095;6454.838629034265;6466.321036291169;6600.250933502578;6622.337766223339;4861.29511220871;4883.8290659826735;4904.166291730343;4915.238138088602;4931.211006238985;4925.532074452921;4934.210526315772;4972.776225069881;4975.850724478271;4984.975075124601;5493.862653433696;5496.422875598085;5541.307336582927;5550.611457197957;5570.721463926788;6316.399942005502;6347.55567110307;6349.936270712037;6406.487481001509;6477.902831457532;1699.600593860442;1700.2997002997004;1717.9828201718074;1719.149021234472;1731.991340043317;1109.8612673415823;1165.4697112813649;1178.3401295274673;1180.7933611617932;1181.1200655511698;5558.138488534284;5558.666480011212;5615.494605485526;5640.464155905182;5644.8871022579315;6524;6582.44049255809;6593.208814942238;6595.934040659532;6623.277947733624;5495.34055913285;5523.226748255248;5548.4174161712435;5594.356648985337;5616.382197958222;3415.9316813663586;3434.862605495752;3437.3812713711272;3452.188735647121;3521.8063006534885;6215.192025036807;6329.810105696836;6336.366363363627;6375.6174629522375;6436.7425302988295;6615.305392933673;6618.536702430783;6620.238672552622;6716.9588713749445;6725.19297684281;6218.098375735493;6260.843478913063;6278.811635651029;6303.275123360872;6316.842078948063;6353.174087368612;6414.807555773335;6458.773942911976;6468.288488266381;6498.512611554247;6385.201849768779;6392.52056095804;6487.18910136233;6503.902441463477;6516.837079073061;5636;6248.875022499434;6263.874722505616;6270.6864656766065;6306.036163003381;4755.167845627071;4781.187198176249;4799.944012317284;4817.590504806991;4838.129136755418;6266.279377871603;6309.684515774285;6350.206224221973;6408.743650254124;6510.73957041732;6145.955187618027;6249.219347199487;6298.968505157445;6302.76251930558;6369;6273.96863015682;6277.748890044347;6303.873922521432;6315.431611155018;6382.521310901608;6215.223097112861;6253.6560489173535;6268.529860260407;6275.246970363585;6279.560430769802;6233.815575040728;6354.809355719336;6384;6416.486681065597;6458.580192287486;6061.484773794277;6128.233970753656;6153.692315384303;6190.659513726608;6197.256329240339 04:02:07 INFO - PID 4129 | |5;yui.html;849.0405841399217;855.3242938078918;864.8745931839883;910.7449914024072;937.7608709779007;19382.224711011542;19725.901370493146;20036.699449508233;20191;20263.696044559325;18692.53268668284;18990.430287091374;19037.143328550213;19043.333483328086;19048.33330833421;961.9711408657752;962.4802606592449;963.5086106085912;964.8215080210183;969.7575606098476;974.5078735238694;979.1921664626711;979.941203527787;998.1765043838826;1017.8778546574422;1062.6918193723811;1064.0529928363724;1064.132731823565;1065.2223876570108;1068.4550879051662;1032.1639472027682;1047.5757318286107;1053.3258714422775;1054.9261551691384;1056.3978532236629;744.2260049548463;750.0324581290129;756.0247281007494;756.7011030642865;761.5468796066332;17954.640907181914;18079;18127.637447251112;18335.26658933641;18381.908090459598;21931.890340548354;22215.555688886132;22365.32904012882;22508.887455562617;22682.20612278579;14628.70742585153;14699.265036748227;14741.115533067943;14782.260886955717;15121.848781512264;3656.232191239843;3683.28176005679;3688.520492336006;3702.7222958278235;3705.203381273039;143043.28478357647;145969;146963;148820.2558987209;149231.25384373116;17194.108648048703;17773.289068437116;17864.642707145784;17901.10494475271;17947.282108715764;32053.198670033435;32632;32869.50695739566;32890.50664240038;32982.835085824416;8579.613917373734;8675.652973880975;8783.648654053894;8895.644174233088;8947.642094316285;3851.826667799956;4256.936145957813;4276.337167739005;4289.785510724514;4297.09760950204;5329.866753331198;5408.945910540923;5433.049216387117;5439.5648348132845;5501.587380946445;967.3325405470204;980.54404701814;994.2096033653263;1006.7080546641392;1011.4639241202175;555.8276934150426;564.8107883858871;577.9856352102034;579.918811366409;590.7430267833506;11248.606298779503;11260.09919206478;11415.458913046632;11537.250078744855;12396.81404778929;600.6846405637076;616.0820377637289;620.1256228717486;621.1366200980641;624.5784095735452;5476.452354764491;5500.312460942382;5564.443555644403;5618;5623.0159722048475;119299;121041;123378.38310808389;126602;128911.35544322219;97569.51215243878;101314.49342753239;102094.4895275519;103493;103665.48167259115;88979.55510222536;90010;91663;91707;91812;9932.900670993198;10167.7458063549;10250.692479225636;10504.212184086071;10550.683479495627;42955.7852210737;43371.13257734891;43599.12801743884;44243.33634995542;45527;55346.44653553413;58611;58623.120653189384;58653.94711185088;58795.41204587899;13675;13878.514252001132;13882.791758123434;13915.860841391457;14076.648083797987;16970.40603578869;16972.575685607957;17064.14679266007;17205.655886882443;17282.567935801704;13349.466021359425;13639.590812275648;13796;13849.37677804481;13851.37668804886;14514.709705806035;14596.927015364856;14700.852991470376;14804.703905922037;14896.776548352;13771.793423098461;13942.860571394156;14040.227787471787;14079.648008799863;14102.435902563782;10958.780824383628;11003.834942475709;11025.669229923114;11237.38194399316;11504.94247528757;11429.257098288585;11436.771264574829;11444.828327574927;11701.473433695333;11768.70578235551 04:02:07 INFO - PID 4129 | __end_tp_report 04:02:07 INFO - PID 4129 | __start_cc_report 04:02:07 INFO - PID 4129 | _x_x_mozilla_cycle_collect,264 04:02:07 INFO - PID 4129 | __end_cc_report 04:02:07 INFO - PID 4129 | __startTimestamp1507028527556__endTimestamp 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | ------- Summary: start ------- 04:02:07 INFO - PID 4129 | Number of tests: 6 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#0] dojo.html Cycles:165 Average:6124.42 Median:6389.87 stddev:785.63 (12.3%) stddev-sans-first:751.38 04:02:07 INFO - PID 4129 | Values: 3100.9 3127.0 3139.7 3150.1 3158.5 6182.6 6214.0 6238.2 6250.5 6306.8 6178.2 6180.6 6183.6 6228.5 6252.1 5633.1 5690.1 5795.8 5806.2 5826.6 5664.0 5777.5 5797.3 5802.3 5849.6 5567.4 5625.8 5652.6 5653.1 5655.9 5666.3 5708.2 5759.0 5777.3 5784.6 5625.0 5672.5 5733.9 5741.6 5772.8 6111.6 6155.4 6171.1 6240.8 6282.3 6566.3 6625.9 6648.5 6649.4 6662.7 6750.8 6840.1 6841.6 6859.4 6875.1 6190.7 6204.7 6234.2 6328.7 6332.8 6847.6 6903.2 6987.0 6997.1 6998.5 6389.9 6553.6 6554.8 6579.8 6598.3 6597.4 6634.4 6720.6 6802.3 6826.5 6696.0 6702.4 6704.5 6723.9 6731.8 6554.3 6658.1 6693.0 6743.9 6756.4 4820.9 4846.2 4888.7 4945.4 4948.7 4233.2 4237.4 4252.9 4283.5 4287.5 5746.5 5749.7 5811.8 5814.5 5817.1 6676.5 6685.8 6745.8 6748.7 6764.5 5706.7 5713.0 5769.7 5773.9 5794.9 5641.8 5672.8 5690.3 5698.2 5711.6 6474.6 6508.4 6524.4 6529.5 6535.8 6668.0 6803.0 6810.2 6819.7 6830.5 6549.9 6550.7 6570.9 6592.6 6593.1 6682.0 6696.2 6710.5 6777.5 6788.1 6565.0 6579.3 6592.9 6596.3 6648.9 6420.8 6449.9 6460.1 6467.3 6471.0 6323.3 6425.6 6430.6 6438.2 6440.1 5795.7 6318.0 6350.3 6394.0 6394.3 6536.6 6599.0 6614.2 6661.9 6664.7 6309.5 6380.4 6381.3 6427.6 6441.6 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#1] ext.html Cycles:180 Average:38234.64 Median:19204.91 stddev:55729.82 (290.2%) stddev-sans-first:55815.46 04:02:07 INFO - PID 4129 | Values: 850.6 867.8 871.2 875.3 876.2 39309.6 43333.6 43434.8 43487.0 43539.9 38263.8 39001.0 39111.8 39137.8 39251.0 7073.1 7233.3 7247.4 7846.1 7979.9 7877.4 7929.4 7962.5 7977.2 8014.6 7969.5 7994.8 8003.8 8022.2 8095.7 7888.4 8031.1 8038.0 8055.7 8058.8 7909.2 7909.6 7917.8 7971.2 7977.8 38680.6 38996.8 39046.4 39121.2 39147.0 3494.4 3525.5 3540.3 3541.8 3544.0 31816.7 31852.4 32078.0 32142.7 32175.2 5113.8 5165.8 5182.7 5191.0 5267.8 206246.0 206363.0 207058.0 207091.0 208502.0 43403.3 49772.5 50365.7 50494.0 50510.7 45804.5 45828.3 51292.7 51456.7 51716.0 15354.6 15506.8 15557.7 15559.1 15578.7 12624.4 12712.9 12724.7 12730.6 12756.7 13268.5 13743.5 13769.7 13776.7 13904.4 5502.8 5569.7 5580.2 5589.3 5685.8 1012.3 1014.8 1018.8 1024.5 1025.4 23272.5 23400.1 23478.0 23554.8 23641.4 1120.5 1137.4 1137.9 1144.5 1147.3 12393.0 12435.5 12438.6 12470.4 12618.5 236519.0 236932.0 237230.0 238822.0 240326.0 54034.7 54113.5 54292.0 54345.5 54481.2 1424.0 1476.2 1479.4 1483.3 1488.6 22644.9 23386.5 23605.5 23789.8 24019.9 34915.5 34964.1 35065.6 35153.3 35234.8 196453.0 197307.0 198194.0 198231.0 198991.0 31668.5 32000.5 33039.0 33938.3 34510.0 43606.0 44340.3 44588.0 44903.3 45214.8 31609.0 32351.8 32510.0 32645.0 32703.0 31360.8 31448.2 31858.8 32092.7 32281.8 36443.8 36610.3 36620.5 36781.3 37059.6 31100.1 31380.0 31488.8 31656.4 31989.4 23210.2 23831.5 24261.3 24372.5 24647.9 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#2] jquery.html Cycles:180 Average:35249.78 Median:23364.68 stddev:80071.73 (342.7%) stddev-sans-first:80254.05 04:02:07 INFO - PID 4129 | Values: 582.1 585.9 587.9 596.5 599.7 22557.2 23269.3 23294.2 23435.2 23498.8 21368.6 21720.3 23010.5 25903.0 25989.7 6535.9 6732.3 6738.9 6739.1 6739.8 6661.6 6750.6 6753.6 6763.8 6773.6 6051.1 6578.3 6584.6 6598.1 6654.9 6600.7 6620.2 6672.3 6674.0 6674.0 5856.3 6147.7 6209.4 6218.6 6237.3 29504.6 30173.4 30200.2 30208.5 30309.2 2022.0 2030.3 2034.3 2053.0 2058.1 19629.5 19643.7 19739.4 19787.3 19947.9 2445.9 2518.5 2518.6 2520.2 2522.1 118692.4 122838.4 122839.0 148702.0 154252.0 20351.3 21370.8 22244.7 22404.3 22927.4 24139.3 44254.0 44653.8 44816.0 45060.0 10353.4 10433.4 10461.2 10463.5 10627.1 9406.2 9509.4 9586.9 9618.1 9745.9 9089.5 9281.0 9380.0 9450.2 9653.9 2642.9 2649.5 2798.3 2805.3 2819.1 956.5 982.3 985.6 988.5 995.5 20216.1 20388.9 20511.2 20536.9 20623.9 1032.1 1038.4 1041.7 1047.6 1064.5 10983.0 11100.2 11188.2 11282.9 11406.7 447634.5 474215.0 474358.0 475267.0 496079.0 121259.4 121492.4 122345.4 122596.4 123788.0 1162.1 1178.0 1189.3 1205.2 1208.2 18305.7 18418.4 18623.4 18798.0 18914.9 53808.5 54665.7 57122.7 57415.0 58901.7 71146.0 71279.0 71587.3 73289.6 74020.0 15333.5 15339.2 15394.2 15545.0 15659.5 23827.6 23830.8 23871.2 24129.3 24217.6 18721.7 18843.4 19143.3 19223.5 19251.8 16632.8 16793.4 16981.7 17127.9 17470.5 18713.6 19163.7 19222.3 19251.1 19351.9 15133.2 15170.9 15239.9 15247.3 15277.5 18468.9 18571.5 18634.7 18830.9 18947.4 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#3] mootools.html Cycles:180 Average:9583.98 Median:2554.64 stddev:6979.43 (273.2%) stddev-sans-first:6971.40 04:02:07 INFO - PID 4129 | Values: 1320.8 1382.7 1395.0 1405.2 1415.7 14214.5 14566.5 14701.6 14770.9 14898.0 14354.6 14387.8 14475.5 14565.0 14605.6 2731.0 2767.5 2811.4 2829.0 2831.7 2658.2 2761.2 2763.7 2763.9 2769.6 2343.9 2497.9 2503.2 2719.1 2756.1 2753.1 2770.8 2774.6 2775.4 2781.6 2543.0 2553.7 2555.5 2580.3 2587.2 15015.4 15443.4 15577.8 15616.1 15640.8 8147.4 8424.4 8453.2 8489.0 8519.3 5176.7 5306.5 5341.4 5429.9 5708.8 1972.1 1998.3 2010.3 2044.2 2048.7 27674.3 27887.9 27913.4 27945.9 27984.7 7285.1 7305.2 7352.9 7394.2 7459.0 20477.3 20671.5 20697.0 20709.9 20773.7 8413.0 8477.7 8482.1 8485.9 8493.7 7204.2 7559.0 7560.7 7610.7 7641.8 5444.6 5681.2 5734.6 5759.8 5813.5 1699.3 1741.2 1774.8 1781.5 1789.2 867.4 870.4 903.8 911.0 917.2 8293.9 8328.4 8391.0 8397.6 8533.6 975.5 997.1 998.5 999.6 1005.6 4613.0 4624.7 4765.3 4790.4 4819.0 21523.5 22446.3 22546.0 22614.0 22771.0 20744.8 21918.5 22195.8 22327.2 22695.8 11384.9 11515.1 11707.2 11783.2 11828.5 7921.2 7942.2 7959.3 7999.4 8044.8 18326.4 18835.5 19234.3 19367.3 19586.6 19343.2 19968.9 20222.8 20313.2 20558.7 10736.3 11058.8 11169.6 11242.7 11322.4 13423.3 13680.7 13723.5 13748.4 13780.0 11182.2 11268.8 11303.5 11409.4 11534.4 10945.7 11078.7 11094.9 11152.9 11389.6 10111.5 10217.2 10238.1 10238.4 10249.0 7376.7 7464.0 7551.7 7567.2 7568.1 7302.7 7367.7 7414.1 7416.7 7472.4 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#4] prototype.html Cycles:180 Average:5353.98 Median:6026.41 stddev:1483.93 (24.6%) stddev-sans-first:1442.67 04:02:07 INFO - PID 4129 | Values: 499.9 507.0 528.5 537.6 540.7 6083.8 6103.7 6104.0 6115.4 6164.5 6051.7 6074.7 6087.8 6102.8 6155.9 5066.9 5068.6 5101.6 5113.4 5127.0 5005.3 5042.5 5067.4 5071.3 5084.7 4740.9 4845.4 4852.7 4889.8 5002.8 4841.8 4883.8 4886.6 4921.1 4925.4 4384.5 4409.1 4429.1 4436.0 4450.8 5728.9 5884.9 5901.3 5903.9 6001.1 5533.4 5552.6 5560.4 5593.4 5598.2 6301.2 6337.9 6352.7 6375.7 6418.8 4485.2 4671.1 4716.4 4747.0 4791.1 6408.5 6454.8 6466.3 6600.3 6622.3 4861.3 4883.8 4904.2 4915.2 4931.2 4925.5 4934.2 4972.8 4975.9 4985.0 5493.9 5496.4 5541.3 5550.6 5570.7 6316.4 6347.6 6349.9 6406.5 6477.9 1699.6 1700.3 1718.0 1719.1 1732.0 1109.9 1165.5 1178.3 1180.8 1181.1 5558.1 5558.7 5615.5 5640.5 5644.9 6524.0 6582.4 6593.2 6595.9 6623.3 5495.3 5523.2 5548.4 5594.4 5616.4 3415.9 3434.9 3437.4 3452.2 3521.8 6215.2 6329.8 6336.4 6375.6 6436.7 6615.3 6618.5 6620.2 6717.0 6725.2 6218.1 6260.8 6278.8 6303.3 6316.8 6353.2 6414.8 6458.8 6468.3 6498.5 6385.2 6392.5 6487.2 6503.9 6516.8 5636.0 6248.9 6263.9 6270.7 6306.0 4755.2 4781.2 4799.9 4817.6 4838.1 6266.3 6309.7 6350.2 6408.7 6510.7 6146.0 6249.2 6299.0 6302.8 6369.0 6274.0 6277.7 6303.9 6315.4 6382.5 6215.2 6253.7 6268.5 6275.2 6279.6 6233.8 6354.8 6384.0 6416.5 6458.6 6061.5 6128.2 6153.7 6190.7 6197.3 04:02:07 INFO - PID 4129 | 04:02:07 INFO - PID 4129 | [#5] yui.html Cycles:180 Average:23975.73 Median:19215.28 stddev:35470.64 (184.6%) stddev-sans-first:35527.64 04:02:07 INFO - PID 4129 | Values: 849.0 855.3 864.9 910.7 937.8 19382.2 19725.9 20036.7 20191.0 20263.7 18692.5 18990.4 19037.1 19043.3 19048.3 962.0 962.5 963.5 964.8 969.8 974.5 979.2 979.9 998.2 1017.9 1062.7 1064.1 1064.1 1065.2 1068.5 1032.2 1047.6 1053.3 1054.9 1056.4 744.2 750.0 756.0 756.7 761.5 17954.6 18079.0 18127.6 18335.3 18381.9 21931.9 22215.6 22365.3 22508.9 22682.2 14628.7 14699.3 14741.1 14782.3 15121.8 3656.2 3683.3 3688.5 3702.7 3705.2 143043.3 145969.0 146963.0 148820.3 149231.3 17194.1 17773.3 17864.6 17901.1 17947.3 32053.2 32632.0 32869.5 32890.5 32982.8 8579.6 8675.7 8783.6 8895.6 8947.6 3851.8 4256.9 4276.3 4289.8 4297.1 5329.9 5408.9 5433.0 5439.6 5501.6 967.3 980.5 994.2 1006.7 1011.5 555.8 564.8 578.0 579.9 590.7 11248.6 11260.1 11415.5 11537.3 12396.8 600.7 616.1 620.1 621.1 624.6 5476.5 5500.3 5564.4 5618.0 5623.0 119299.0 121041.0 123378.4 126602.0 128911.4 97569.5 101314.5 102094.5 103493.0 103665.5 88979.6 90010.0 91663.0 91707.0 91812.0 9932.9 10167.7 10250.7 10504.2 10550.7 42955.8 43371.1 43599.1 44243.3 45527.0 55346.4 58611.0 58623.1 58653.9 58795.4 13675.0 13878.5 13882.8 13915.9 14076.6 16970.4 16972.6 17064.1 17205.7 17282.6 13349.5 13639.6 13796.0 13849.4 13851.4 14514.7 14596.9 14700.9 14804.7 14896.8 13771.8 13942.9 14040.2 14079.6 14102.4 10958.8 11003.8 11025.7 11237.4 11504.9 11429.3 11436.8 11444.8 11701.5 11768.7 04:02:07 INFO - PID 4129 | -------- Summary: end -------- 04:02:07 INFO - PID 4129 | 04:02:08 INFO - TEST-INFO | 4129: exit 0 04:02:08 INFO - TEST-OK | dromaeo_css | took 1116290ms 04:02:08 INFO - TEST-START | kraken 04:02:08 INFO - Initialising browser for kraken test... 04:02:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40594/getInfo.html -profile /tmp/tmpuFdjjT/profile 04:02:08 INFO - TEST-INFO | started process 4560 (/builds/slave/test/build/application/firefox/firefox http://localhost:40594/getInfo.html) 04:02:14 INFO - TEST-INFO | 4560: exit 0 04:02:14 INFO - Browser initialized. 04:02:14 INFO - Running cycle 1/1 for kraken test... 04:02:14 INFO - Using env: {'DISPLAY': ':0', 04:02:14 INFO - 'HOME': '/home/cltbld', 04:02:14 INFO - 'JSGC_DISABLE_POISONING': '1', 04:02:14 INFO - 'LANG': 'en_US.UTF-8', 04:02:14 INFO - 'LANGUAGE': 'en_US:en', 04:02:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:02:14 INFO - 'LOGNAME': 'cltbld', 04:02:14 INFO - 'MAIL': '/var/mail/cltbld', 04:02:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:14 INFO - 'MOZ_ACCELERATED': '1', 04:02:14 INFO - 'MOZ_CRASHREPORTER': '1', 04:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:02:14 INFO - 'MOZ_NO_REMOTE': '1', 04:02:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:14 INFO - 'MOZ_WEBRENDER': '1', 04:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:14 INFO - 'NO_EM_RESTART': '1', 04:02:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:14 INFO - 'PWD': '/builds/slave/test', 04:02:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:14 INFO - 'RUST_BACKTRACE': 'full', 04:02:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:14 INFO - 'SHELL': '/bin/bash', 04:02:14 INFO - 'SHLVL': '1', 04:02:14 INFO - 'TERM': 'linux', 04:02:14 INFO - 'TMOUT': '86400', 04:02:14 INFO - 'USER': 'cltbld', 04:02:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1507014692.838275-1376920695', 04:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:14 INFO - '_': '/tools/buildbot/bin/python'} 04:02:14 INFO - TEST-INFO | started process 4846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuFdjjT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:15 INFO - PID 4846 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:02:15 INFO - PID 4846 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:02:15 INFO - PID 4846 | 04:02:15 INFO - PID 4846 | (/builds/slave/test/build/application/firefox/firefox:4904): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:02:15 INFO - PID 4846 | 04:02:26 INFO - PID 4846 | RSS: Main: 209711104 04:02:26 INFO - PID 4846 | 04:02:28 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40594/tests/kraken/driver.html?testName=audio-beat-detection) 04:02:29 INFO - PID 4846 | RSS: Main: 211632128 04:02:29 INFO - PID 4846 | 04:02:32 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40594/tests/kraken/driver.html?testName=audio-dft) 04:02:32 INFO - PID 4846 | RSS: Main: 211939328 04:02:32 INFO - PID 4846 | 04:02:36 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40594/tests/kraken/driver.html?testName=audio-fft) 04:02:36 INFO - PID 4846 | RSS: Main: 207921152 04:02:36 INFO - PID 4846 | 04:02:38 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40594/tests/kraken/driver.html?testName=audio-oscillator) 04:02:39 INFO - PID 4846 | RSS: Main: 207642624 04:02:39 INFO - PID 4846 | 04:02:41 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:02:42 INFO - PID 4846 | RSS: Main: 208158720 04:02:42 INFO - PID 4846 | 04:02:45 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40594/tests/kraken/driver.html?testName=imaging-darkroom) 04:02:46 INFO - PID 4846 | RSS: Main: 210468864 04:02:46 INFO - PID 4846 | 04:02:49 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40594/tests/kraken/driver.html?testName=imaging-desaturate) 04:02:50 INFO - PID 4846 | RSS: Main: 210595840 04:02:50 INFO - PID 4846 | 04:02:53 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40594/tests/kraken/driver.html?testName=json-parse-financial) 04:02:54 INFO - PID 4846 | RSS: Main: 211296256 04:02:54 INFO - PID 4846 | 04:02:55 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:56 INFO - PID 4846 | RSS: Main: 211095552 04:02:56 INFO - PID 4846 | 04:02:58 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:58 INFO - PID 4846 | RSS: Main: 207753216 04:02:58 INFO - PID 4846 | 04:03:00 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:01 INFO - PID 4846 | RSS: Main: 207941632 04:03:01 INFO - PID 4846 | 04:03:04 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:04 INFO - PID 4846 | RSS: Main: 208474112 04:03:04 INFO - PID 4846 | 04:03:07 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:08 INFO - PID 4846 | RSS: Main: 208359424 04:03:08 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | Cycle 1(1): loaded http://localhost:40594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40594/tests/kraken/driver.html?testName=ai-astar) 04:03:10 INFO - PID 4846 | RSS: Main: 209108992 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | __start_tp_report 04:03:10 INFO - PID 4846 | _x_x_mozilla_page_load 04:03:10 INFO - PID 4846 | _x_x_mozilla_page_load_details 04:03:10 INFO - PID 4846 | |i|pagename|runs| 04:03:10 INFO - PID 4846 | |0;ai-astar;110;113;107;108;116;108;118;115;111;119 04:03:10 INFO - PID 4846 | |1;audio-beat-detection;121;122;118;119;118;142;115;121;117;118 04:03:10 INFO - PID 4846 | |2;audio-dft;164;165;173;173;163;176;167;171;165;171 04:03:10 INFO - PID 4846 | |3;audio-fft;79;77;78;78;78;75;73;77;77;75 04:03:10 INFO - PID 4846 | |4;audio-oscillator;82;79;79;78;88;85;80;82;83;86 04:03:10 INFO - PID 4846 | |5;imaging-gaussian-blur;123;116;114;114;114;115;117;120;122;124 04:03:10 INFO - PID 4846 | |6;imaging-darkroom;160;148;147;155;152;151;154;152;158;150 04:03:10 INFO - PID 4846 | |7;imaging-desaturate;94;94;94;95;96;95;96;94;94;99 04:03:10 INFO - PID 4846 | |8;json-parse-financial;57;54;58;53;52;52;58;52;53;53 04:03:10 INFO - PID 4846 | |9;json-stringify-tinderbox;40;45;42;41;45;37;42;47;50;41 04:03:10 INFO - PID 4846 | |10;stanford-crypto-aes;77;70;77;74;71;78;74;78;78;82 04:03:10 INFO - PID 4846 | |11;stanford-crypto-ccm;120;110;110;127;114;114;123;116;114;113 04:03:10 INFO - PID 4846 | |12;stanford-crypto-pbkdf2;178;170;165;161;163;166;175;165;167;172 04:03:10 INFO - PID 4846 | |13;stanford-crypto-sha256-iterative;69;66;65;63;65;66;63;67;63;62 04:03:10 INFO - PID 4846 | __end_tp_report 04:03:10 INFO - PID 4846 | __start_cc_report 04:03:10 INFO - PID 4846 | _x_x_mozilla_cycle_collect,754 04:03:10 INFO - PID 4846 | __end_cc_report 04:03:10 INFO - PID 4846 | __startTimestamp1507028590292__endTimestamp 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | ------- Summary: start ------- 04:03:10 INFO - PID 4846 | Number of tests: 14 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:4.35 (3.8%) stddev-sans-first:4.52 04:03:10 INFO - PID 4846 | Values: 110.0 113.0 107.0 108.0 116.0 108.0 118.0 115.0 111.0 119.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:120.00 stddev:7.64 (6.4%) stddev-sans-first:8.10 04:03:10 INFO - PID 4846 | Values: 121.0 122.0 118.0 119.0 118.0 142.0 115.0 121.0 117.0 118.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#2] audio-dft Cycles:10 Average:168.80 Median:171.00 stddev:4.54 (2.7%) stddev-sans-first:4.47 04:03:10 INFO - PID 4846 | Values: 164.0 165.0 173.0 173.0 163.0 176.0 167.0 171.0 165.0 171.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#3] audio-fft Cycles:10 Average:76.70 Median:77.50 stddev:1.83 (2.4%) stddev-sans-first:1.74 04:03:10 INFO - PID 4846 | Values: 79.0 77.0 78.0 78.0 78.0 75.0 73.0 77.0 77.0 75.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:82.50 stddev:3.33 (4.0%) stddev-sans-first:3.53 04:03:10 INFO - PID 4846 | Values: 82.0 79.0 79.0 78.0 88.0 85.0 80.0 82.0 83.0 86.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.50 stddev:3.98 (3.4%) stddev-sans-first:3.77 04:03:10 INFO - PID 4846 | Values: 123.0 116.0 114.0 114.0 114.0 115.0 117.0 120.0 122.0 124.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:153.00 stddev:4.14 (2.7%) stddev-sans-first:3.44 04:03:10 INFO - PID 4846 | Values: 160.0 148.0 147.0 155.0 152.0 151.0 154.0 152.0 158.0 150.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.64 04:03:10 INFO - PID 4846 | Values: 94.0 94.0 94.0 95.0 96.0 95.0 96.0 94.0 94.0 99.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:2.49 (4.6%) stddev-sans-first:2.42 04:03:10 INFO - PID 4846 | Values: 57.0 54.0 58.0 53.0 52.0 52.0 58.0 52.0 53.0 53.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#9] json-stringify-tinderbox Cycles:10 Average:43.00 Median:43.50 stddev:3.77 (8.7%) stddev-sans-first:3.84 04:03:10 INFO - PID 4846 | Values: 40.0 45.0 42.0 41.0 45.0 37.0 42.0 47.0 50.0 41.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:77.50 stddev:3.63 (4.7%) stddev-sans-first:3.83 04:03:10 INFO - PID 4846 | Values: 77.0 70.0 77.0 74.0 71.0 78.0 74.0 78.0 78.0 82.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:115.00 stddev:5.57 (4.8%) stddev-sans-first:5.72 04:03:10 INFO - PID 4846 | Values: 120.0 110.0 110.0 127.0 114.0 114.0 123.0 116.0 114.0 113.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:5.43 (3.2%) stddev-sans-first:4.46 04:03:10 INFO - PID 4846 | Values: 178.0 170.0 165.0 161.0 163.0 166.0 175.0 165.0 167.0 172.0 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.18 (3.3%) stddev-sans-first:1.74 04:03:10 INFO - PID 4846 | Values: 69.0 66.0 65.0 63.0 65.0 66.0 63.0 67.0 63.0 62.0 04:03:10 INFO - PID 4846 | -------- Summary: end -------- 04:03:10 INFO - PID 4846 | 04:03:10 INFO - PID 4846 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:03:11 INFO - TEST-INFO | 4846: exit 0 04:03:11 INFO - TEST-OK | kraken | took 62864ms 04:03:11 INFO - SUITE-END | took 1179s 04:03:11 INFO - Completed test suite (00:19:39) 04:03:11 INFO - javascript benchmark 04:03:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8509.433751585539, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.8759649614003, 3127.0306205076427, 3139.733122684571, 3150.070729134905, 3158.510430883211, 6182.598131121474, 6214.0, 6238.189035425394, 6250.499960003201, 6306.842328941779, 6178.227721534809, 6180.598261113036, 6183.628982261056, 6228.470580000694, 6252.093446450262, 5633.070543360361, 5690.06113991191, 5795.840831833629, 5806.158107074471, 5826.6212696174825, 5663.971680141593, 5777.45114214149, 5797.333306669745, 5802.274715660543, 5849.619774714652, 5567.4432556744205, 5625.774969001235, 5652.63257888236, 5653.123765816305, 5655.943440565604, 5666.348369937427, 5708.172315014342, 5759.0, 5777.277840269966, 5784.623999440065, 5625.0, 5672.546196304285, 5733.942660573424, 5741.569382296345, 5772.769089236425, 6111.602745821552, 6155.415235552616, 6171.105189747506, 6240.781572644935, 6282.340354262828, 6566.310537393552, 6625.900611490832, 6648.534602577822, 6649.4347980421235, 6662.700178491979, 6750.797476075725, 6840.11078559789, 6841.589504629738, 6859.382655560974, 6875.106236189314, 6190.690465476753, 6204.720787564571, 6234.18955535782, 6328.715207815613, 6332.810015699536, 6847.554908930903, 6903.1716194057035, 6987.021816945632, 6997.055397521372, 6998.510104292651, 6389.872202555923, 6553.639549824806, 6554.754596626625, 6579.835504112435, 6598.307177746267, 6597.406233439014, 6634.436072933855, 6720.630365329856, 6802.285759995229, 6826.453883689393, 6696.029075783984, 6702.430293425016, 6704.497162712719, 6723.865522689519, 6731.764388246388, 6554.279029306773, 6658.1011563438315, 6693.029510720919, 6743.9325606743305, 6756.358145976124, 4820.903581928342, 4846.224604063404, 4888.7311197884455, 4945.406551213805, 4948.703077815343, 4233.153369326147, 4237.427947227146, 4252.85115020979, 4283.464566929134, 4287.549807270192, 5746.511546518509, 5749.741261643152, 5811.767529298865, 5814.534837213013, 5817.069268916953, 6676.499262555328, 6685.79942601713, 6745.763898263537, 6748.662566871637, 6764.526483146231, 5706.686132262766, 5712.971435142797, 5769.68266745333, 5773.913391299134, 5794.88410231793, 5641.774329026793, 5672.7730890763905, 5690.3456102548735, 5698.1737648041635, 5711.628744131618, 6474.611523308617, 6508.381703738138, 6524.445422139172, 6529.510286728514, 6535.8366040848405, 6668.0, 6802.97955306708, 6810.182778066664, 6819.727210911508, 6830.5218634697085, 6549.901751473636, 6550.672466376757, 6570.868582628416, 6592.604443733391, 6593.142891424084, 6682.031105489774, 6696.229933557508, 6710.463162946855, 6777.491688123509, 6788.117544719353, 6565.048068030204, 6579.342065793382, 6592.934070659232, 6596.3073877244115, 6648.90026649591, 6420.839479013062, 6449.935500644933, 6460.12788273577, 6467.320931302145, 6470.967645161744, 6323.304436511888, 6425.614463132227, 6430.64631445275, 6438.195225596801, 6440.0983862260255, 5795.652260864362, 6318.020706790455, 6350.269718982377, 6393.968030160006, 6394.328595497405, 6536.575122617015, 6599.0, 6614.206295244409, 6661.933380666132, 6664.666766661744, 6309.49524038085, 6380.425761681471, 6381.266154392304, 6427.550071495138, 6441.613503189824], "value": 6061.11009410937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.6214734443172, 867.8481265778487, 871.1854416120927, 875.2953872132938, 876.2114097312418, 39309.60690393095, 43333.566664333346, 43434.78282608582, 43487.0, 43539.911502212424, 38263.80868095656, 39001.0, 39111.80444097782, 39137.804310978405, 39251.0, 7073.080499535066, 7233.276672332777, 7247.420206383503, 7846.136924938252, 7979.880301795478, 7877.369810415153, 7929.444938854283, 7962.52224866507, 7977.162397948219, 8014.599270036504, 7969.521828690268, 7994.840103197933, 8003.759887203393, 8022.1576734442915, 8095.7166499172545, 7888.368930485547, 8031.076426210973, 8038.0, 8055.718049868285, 8058.798530036796, 7909.24862138096, 7909.644066017043, 7917.7624671259955, 7971.242731940456, 7977.760667179994, 38680.61319386798, 38996.80501597502, 39046.41430378547, 39121.21757564861, 39147.0, 3494.353544594258, 3525.5240542526685, 3540.327337805809, 3541.8052007139595, 3544.025393016941, 31816.681833181603, 31852.36295274105, 32078.0, 32142.678573214434, 32175.19562010945, 5113.795448182068, 5165.793368265265, 5182.740862956837, 5191.0, 5267.815626453055, 206246.0, 206363.0, 207058.0, 207091.0, 208502.0, 43403.34894976578, 49772.50227497751, 50365.74817125891, 50494.0, 50510.74744626253, 45804.541954580694, 45828.3125753114, 51292.74353628208, 51456.74271628618, 51716.0, 15354.616134596501, 15506.767398489032, 15557.688846223238, 15559.144247066293, 15578.688426231412, 12624.431900564497, 12712.872871271355, 12724.745505089846, 12730.554430594884, 12756.681082972815, 13268.469261229635, 13743.450261989408, 13769.655758605915, 13776.655583610289, 13904.374303156383, 5502.8349149525575, 5569.66582005081, 5580.19087232349, 5589.329280486368, 5685.800996965169, 1012.336919317848, 1014.761531040205, 1018.7860549284733, 1024.4519182237616, 1025.4257615735212, 23272.534549309257, 23400.06399744025, 23478.0, 23554.7644523556, 23641.408964775674, 1120.506976930148, 1137.351709525579, 1137.9089672826153, 1144.4792619358172, 1147.3460127727114, 12393.0, 12435.502579896884, 12438.564650237198, 12470.43883025266, 12618.495260189673, 236519.0, 236932.0, 237230.0, 238822.0, 240326.0, 54034.7298263514, 54113.45886541163, 54292.0, 54345.456545434834, 54481.1827822583, 1423.992880035593, 1476.1733429279639, 1479.4452080469823, 1483.3325003748357, 1488.6352843553398, 22644.886775566676, 23386.53226935418, 23605.52788944246, 23789.762102378754, 24019.879900601085, 34915.4762678555, 34964.12589685278, 35065.64934350624, 35153.296934061684, 35234.8238258807, 196453.0, 197307.0, 198194.0, 198231.0, 198991.0, 31668.524972124975, 32000.5199922006, 33039.0, 33938.321233574694, 34510.0, 43606.0, 44340.33489497595, 44588.0, 44903.32645010262, 45214.77392613148, 31609.0, 32351.838240808644, 32510.0, 32645.0, 32703.0, 31360.843195783877, 31448.213794655316, 31858.840705796323, 32092.679073209903, 32281.838590807834, 36443.817780910926, 36610.26779464449, 36620.45069323909, 36781.26437471182, 37059.62940370562, 31100.066997990096, 31380.0, 31488.84255578799, 31656.36687266288, 31989.36021279515, 23210.1876434324, 23831.523369532166, 24261.27216183517, 24372.51254974855, 24647.876760616084], "value": 17248.144978304732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1413415212562, 585.8828234353127, 587.944145306196, 596.5317225977607, 599.6731781179262, 22557.210497632586, 23269.301920942376, 23294.18470353538, 23435.179768708098, 23498.76501234987, 21368.57262854742, 21720.34838954834, 23010.539789204206, 25903.0, 25989.740102599015, 6535.901961470569, 6732.259451460335, 6738.898916516257, 6739.09022281993, 6739.797806065826, 6661.566998145105, 6750.56121352113, 6753.561018533805, 6763.763268285611, 6773.593584384953, 6051.092336149569, 6578.276389597165, 6584.604923704569, 6598.109255250528, 6654.933450665504, 6600.6699665016795, 6620.172478440195, 6672.299408562079, 6673.966630166842, 6673.966630166867, 5856.32652244993, 6147.692615369258, 6209.410106039919, 6218.595791273553, 6237.313895471494, 29504.557431638543, 30173.396532069237, 30200.18798872053, 30208.54687179694, 30309.24226894323, 2022.049636670777, 2030.3401394546831, 2034.338839877046, 2052.989735051315, 2058.053295484079, 19629.50926226856, 19643.705344419846, 19739.40781776549, 19787.30744423938, 19947.90026049875, 2445.9388515287083, 2518.4837108392735, 2518.5718427867123, 2520.206135067448, 2522.1424715596786, 118692.40653796762, 122838.38580807128, 122839.0, 148702.0, 154252.0, 20351.25258090139, 21370.78629213719, 22244.666330005064, 22404.31148262219, 22927.426814329443, 24139.275821725376, 44254.0, 44653.77673111614, 44816.0, 45060.0, 10353.378797272037, 10433.373997560171, 10461.163106951426, 10463.476826158661, 10627.14982801374, 9406.247500199968, 9509.381890177116, 9586.904130958601, 9618.134367906781, 9745.902540974641, 9089.545522723838, 9281.0, 9379.953100234456, 9450.243980481546, 9653.855192172123, 2642.907498237591, 2649.496595646821, 2798.3423895384567, 2805.2689922403156, 2819.1119797264205, 956.4691596164196, 982.268210183418, 985.571276494727, 988.4958671077802, 995.5022488755623, 20216.09027593762, 20388.898055509922, 20511.17955281802, 20536.897315513626, 20623.8968805158, 1032.0659802878406, 1038.4288641247283, 1041.729150420896, 1047.6490375724218, 1064.505005172583, 10983.0, 11100.167487438475, 11188.160887933274, 11282.94358528202, 11406.714832129097, 447634.5236547593, 474215.0, 474358.0, 475267.0, 496079.0, 121259.39370303092, 121492.39253803674, 122345.38827305984, 122596.38701806434, 123788.0, 1162.0877611075266, 1178.0, 1189.3280296632374, 1205.2045649871043, 1208.1663652080038, 18305.725414119064, 18418.447446576625, 18623.44129676058, 18798.0, 18914.905425473335, 53808.46191538034, 54665.72667136639, 57122.71438642946, 57415.0, 58901.705491473986, 71146.0, 71279.0, 71587.28412715805, 73289.6335518319, 74020.0, 15333.463328783439, 15339.156346401054, 15394.230288485754, 15545.0, 15659.451919182773, 23827.642585360885, 23830.761692382854, 23871.164509242095, 24129.276121716375, 24217.63673544863, 18721.719174212125, 18843.434696959113, 19143.329983450512, 19223.51941201481, 19251.807481925003, 16632.75050874262, 16793.41223057187, 16981.658692185305, 17127.91436042812, 17470.47588572345, 18713.625727485647, 19163.71254431157, 19222.327218547285, 19251.1336989833, 19351.90324048427, 15133.243337832844, 15170.924145379202, 15239.923800380928, 15247.313870875616, 15277.465288714842, 18468.907655461637, 18571.535711607317, 18634.72047919255, 18830.905845470686, 18947.43157705271], "value": 12476.15033511515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.8414990201177, 1382.730367578322, 1394.9790753138711, 1405.2271250812057, 1415.7239338329023, 14214.502492412756, 14566.490172843953, 14701.632459188526, 14770.85229147707, 14898.0, 14354.641133971656, 14387.78418323726, 14475.493357732481, 14565.0, 14605.634859128528, 2730.959035614467, 2767.5433553463704, 2811.3955499567587, 2828.9532872836976, 2831.730985556369, 2658.215826331227, 2761.2130542795308, 2763.7236276372405, 2763.875625596843, 2769.556870900656, 2343.9296821095395, 2497.8751062446895, 2503.236512863576, 2719.1434698070143, 2756.1180422264883, 2753.1190019193864, 2770.8476033818133, 2774.569941659046, 2775.4449110177943, 2781.5549512078073, 2543.0082267915527, 2553.7318581549043, 2555.540002799495, 2580.251726999168, 2587.223832850156, 15015.399384024735, 15443.382264709398, 15577.844221557752, 15616.063036217864, 15640.843591564166, 8147.388945829087, 8424.368172387034, 8453.239208471206, 8489.0, 8519.318454523685, 5176.715280659562, 5306.522412982811, 5341.385740639837, 5429.891402171974, 5708.77164913403, 1972.0731256309512, 1998.2706312195944, 2010.2963962613114, 2044.2334124703236, 2048.7131801547794, 27674.308142296402, 27887.86056069727, 27913.441731165465, 27945.86027069872, 27984.720152798414, 7285.125784905846, 7305.159906610702, 7352.926470735224, 7394.223606521346, 7459.0, 20477.283295084897, 20671.483212919797, 20697.0, 20709.896450517652, 20773.68839467379, 8412.957935210285, 8477.74566762998, 8482.066972633005, 8485.872711909326, 8493.745187644381, 7204.207537170907, 7559.0, 7560.659770310349, 7610.657520411595, 7641.808954776175, 5444.618876678674, 5681.176229446707, 5734.569907256972, 5759.798407055733, 5813.505852002542, 1699.2608215426328, 1741.172942852135, 1774.8225177482148, 1781.5278951077976, 1789.185920406212, 867.3624885708999, 870.4211699219948, 903.7830920579145, 910.9908900911039, 917.2295271971443, 8293.875591866126, 8328.417010809186, 8391.0, 8397.580120994047, 8533.615987280587, 975.5268694683073, 997.0627610046533, 998.5207100591612, 999.6401295533602, 1005.5826831864695, 4613.0, 4624.676272660881, 4765.332853400527, 4790.449098353734, 4818.95181048185, 21523.461913452287, 22446.32661020172, 22546.0, 22614.0, 22771.0, 20744.79255207459, 21918.45203869916, 22195.778042219696, 22327.218547350763, 22695.773042269368, 11384.943075284571, 11515.136364772508, 11707.239029463057, 11783.175177737647, 11828.467718952668, 7921.1682773307975, 7942.245486678757, 7959.323457505945, 7999.400044996765, 8044.839103217786, 18326.358577449726, 18835.529111772314, 19234.326798561982, 19367.3221437249, 19586.60826783428, 19343.226270949006, 19968.90015549913, 20222.79777202209, 20313.187472501526, 20558.691619626017, 10736.30214036085, 11058.778824423627, 11169.553217871195, 11242.66272011841, 11322.433878306216, 13423.328833558087, 13680.65798355049, 13723.519676811264, 13748.381322840696, 13780.0, 11182.161337899528, 11268.830967535658, 11303.491342889425, 11409.429528523375, 11534.423278836193, 10945.726356841144, 11078.667639970814, 11094.889051109709, 11152.88847111551, 11389.601363952223, 10111.544980476043, 10217.23370747182, 10238.12975897057, 10238.436885971343, 10249.026342497451, 7376.7049318026675, 7464.0, 7551.73568925085, 7567.167611562613, 7568.091828980338, 7302.744403945836, 7367.742129025459, 7414.147373052168, 7416.7404140854815, 7472.40220782347], "value": 6821.603686237694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.9025190087932, 506.99239511407313, 528.53184502973, 537.5914305128101, 540.6864018869056, 6083.847903802402, 6103.664298463583, 6103.969480152604, 6115.41903519166, 6164.537659675526, 6051.697415129237, 6074.696265186745, 6087.817365479032, 6102.786402475915, 6155.938440615592, 5066.949330506703, 5068.619853510983, 5101.617378696594, 5113.411957624883, 5126.974365128169, 5005.349304590398, 5042.47054059324, 5067.391912970449, 5071.264666623338, 5084.694918304895, 4740.90518189636, 4845.37010188675, 4852.733099679516, 4889.755512224392, 5002.799328161252, 4841.782119804618, 4883.755812209375, 4886.560209581155, 4921.138800709898, 4925.359703238574, 4384.495782984965, 4409.118176364708, 4429.114177164548, 4436.0, 4450.777461126931, 5728.8854222915725, 5884.911726324066, 5901.2918449785875, 5903.852403689899, 6001.129836173774, 5533.418991005927, 5552.555795536387, 5560.36055853578, 5593.440655934414, 5598.188262701886, 6301.179597607834, 6337.904931426032, 6352.745890164388, 6375.661111166614, 6418.775342862978, 4485.192665320241, 4671.11248862715, 4716.3632909557455, 4746.952530474686, 4791.113643975876, 6408.455281301095, 6454.838629034265, 6466.321036291169, 6600.250933502578, 6622.337766223339, 4861.29511220871, 4883.8290659826735, 4904.166291730343, 4915.238138088602, 4931.211006238985, 4925.532074452921, 4934.210526315772, 4972.776225069881, 4975.850724478271, 4984.975075124601, 5493.862653433696, 5496.422875598085, 5541.307336582927, 5550.611457197957, 5570.721463926788, 6316.399942005502, 6347.55567110307, 6349.936270712037, 6406.487481001509, 6477.902831457532, 1699.600593860442, 1700.2997002997004, 1717.9828201718074, 1719.149021234472, 1731.991340043317, 1109.8612673415823, 1165.4697112813649, 1178.3401295274673, 1180.7933611617932, 1181.1200655511698, 5558.138488534284, 5558.666480011212, 5615.494605485526, 5640.464155905182, 5644.8871022579315, 6524.0, 6582.44049255809, 6593.208814942238, 6595.934040659532, 6623.277947733624, 5495.34055913285, 5523.226748255248, 5548.4174161712435, 5594.356648985337, 5616.382197958222, 3415.9316813663586, 3434.862605495752, 3437.3812713711272, 3452.188735647121, 3521.8063006534885, 6215.192025036807, 6329.810105696836, 6336.366363363627, 6375.6174629522375, 6436.7425302988295, 6615.305392933673, 6618.536702430783, 6620.238672552622, 6716.9588713749445, 6725.19297684281, 6218.098375735493, 6260.843478913063, 6278.811635651029, 6303.275123360872, 6316.842078948063, 6353.174087368612, 6414.807555773335, 6458.773942911976, 6468.288488266381, 6498.512611554247, 6385.201849768779, 6392.52056095804, 6487.18910136233, 6503.902441463477, 6516.837079073061, 5636.0, 6248.875022499434, 6263.874722505616, 6270.6864656766065, 6306.036163003381, 4755.167845627071, 4781.187198176249, 4799.944012317284, 4817.590504806991, 4838.129136755418, 6266.279377871603, 6309.684515774285, 6350.206224221973, 6408.743650254124, 6510.73957041732, 6145.955187618027, 6249.219347199487, 6298.968505157445, 6302.76251930558, 6369.0, 6273.96863015682, 6277.748890044347, 6303.873922521432, 6315.431611155018, 6382.521310901608, 6215.223097112861, 6253.6560489173535, 6268.529860260407, 6275.246970363585, 6279.560430769802, 6233.815575040728, 6354.809355719336, 6384.0, 6416.486681065597, 6458.580192287486, 6061.484773794277, 6128.233970753656, 6153.692315384303, 6190.659513726608, 6197.256329240339], "value": 4920.07855082041, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.0405841399217, 855.3242938078918, 864.8745931839883, 910.7449914024072, 937.7608709779007, 19382.224711011542, 19725.901370493146, 20036.699449508233, 20191.0, 20263.696044559325, 18692.53268668284, 18990.430287091374, 19037.143328550213, 19043.333483328086, 19048.33330833421, 961.9711408657752, 962.4802606592449, 963.5086106085912, 964.8215080210183, 969.7575606098476, 974.5078735238694, 979.1921664626711, 979.941203527787, 998.1765043838826, 1017.8778546574422, 1062.6918193723811, 1064.0529928363724, 1064.132731823565, 1065.2223876570108, 1068.4550879051662, 1032.1639472027682, 1047.5757318286107, 1053.3258714422775, 1054.9261551691384, 1056.3978532236629, 744.2260049548463, 750.0324581290129, 756.0247281007494, 756.7011030642865, 761.5468796066332, 17954.640907181914, 18079.0, 18127.637447251112, 18335.26658933641, 18381.908090459598, 21931.890340548354, 22215.555688886132, 22365.32904012882, 22508.887455562617, 22682.20612278579, 14628.70742585153, 14699.265036748227, 14741.115533067943, 14782.260886955717, 15121.848781512264, 3656.232191239843, 3683.28176005679, 3688.520492336006, 3702.7222958278235, 3705.203381273039, 143043.28478357647, 145969.0, 146963.0, 148820.2558987209, 149231.25384373116, 17194.108648048703, 17773.289068437116, 17864.642707145784, 17901.10494475271, 17947.282108715764, 32053.198670033435, 32632.0, 32869.50695739566, 32890.50664240038, 32982.835085824416, 8579.613917373734, 8675.652973880975, 8783.648654053894, 8895.644174233088, 8947.642094316285, 3851.826667799956, 4256.936145957813, 4276.337167739005, 4289.785510724514, 4297.09760950204, 5329.866753331198, 5408.945910540923, 5433.049216387117, 5439.5648348132845, 5501.587380946445, 967.3325405470204, 980.54404701814, 994.2096033653263, 1006.7080546641392, 1011.4639241202175, 555.8276934150426, 564.8107883858871, 577.9856352102034, 579.918811366409, 590.7430267833506, 11248.606298779503, 11260.09919206478, 11415.458913046632, 11537.250078744855, 12396.81404778929, 600.6846405637076, 616.0820377637289, 620.1256228717486, 621.1366200980641, 624.5784095735452, 5476.452354764491, 5500.312460942382, 5564.443555644403, 5618.0, 5623.0159722048475, 119299.0, 121041.0, 123378.38310808389, 126602.0, 128911.35544322219, 97569.51215243878, 101314.49342753239, 102094.4895275519, 103493.0, 103665.48167259115, 88979.55510222536, 90010.0, 91663.0, 91707.0, 91812.0, 9932.900670993198, 10167.7458063549, 10250.692479225636, 10504.212184086071, 10550.683479495627, 42955.7852210737, 43371.13257734891, 43599.12801743884, 44243.33634995542, 45527.0, 55346.44653553413, 58611.0, 58623.120653189384, 58653.94711185088, 58795.41204587899, 13675.0, 13878.514252001132, 13882.791758123434, 13915.860841391457, 14076.648083797987, 16970.40603578869, 16972.575685607957, 17064.14679266007, 17205.655886882443, 17282.567935801704, 13349.466021359425, 13639.590812275648, 13796.0, 13849.37677804481, 13851.37668804886, 14514.709705806035, 14596.927015364856, 14700.852991470376, 14804.703905922037, 14896.776548352, 13771.793423098461, 13942.860571394156, 14040.227787471787, 14079.648008799863, 14102.435902563782, 10958.780824383628, 11003.834942475709, 11025.669229923114, 11237.38194399316, 11504.94247528757, 11429.257098288585, 11436.771264574829, 11444.828327574927, 11701.473433695333, 11768.70578235551], "value": 8672.470996484577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 107.0, 108.0, 116.0, 108.0, 118.0, 115.0, 111.0, 119.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 118.0, 119.0, 118.0, 142.0, 115.0, 121.0, 117.0, 118.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 173.0, 173.0, 163.0, 176.0, 167.0, 171.0, 165.0, 171.0], "value": 168.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 78.0, 78.0, 75.0, 73.0, 77.0, 77.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 78.0, 88.0, 85.0, 80.0, 82.0, 83.0, 86.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 116.0, 114.0, 114.0, 114.0, 115.0, 117.0, 120.0, 122.0, 124.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 148.0, 147.0, 155.0, 152.0, 151.0, 154.0, 152.0, 158.0, 150.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 96.0, 95.0, 96.0, 94.0, 94.0, 99.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 58.0, 53.0, 52.0, 52.0, 58.0, 52.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 45.0, 42.0, 41.0, 45.0, 37.0, 42.0, 47.0, 50.0, 41.0], "value": 43.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 70.0, 77.0, 74.0, 71.0, 78.0, 74.0, 78.0, 78.0, 82.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 110.0, 127.0, 114.0, 114.0, 123.0, 116.0, 114.0, 113.0], "value": 116.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 165.0, 161.0, 163.0, 166.0, 175.0, 165.0, 167.0, 172.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 65.0, 63.0, 65.0, 66.0, 63.0, 67.0, 63.0, 62.0], "value": 64.9, "unit": "score"}]}]} 04:03:11 INFO - Return code: 0 04:03:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:03:11 INFO - # TBPL SUCCESS # 04:03:11 INFO - Running post-action listener: _package_coverage_data 04:03:11 INFO - Running post-action listener: _resource_record_post_action 04:03:11 INFO - [mozharness: 2017-10-03 11:03:11.601078Z] Finished run-tests step (success) 04:03:11 INFO - Running post-run listener: _resource_record_post_run 04:03:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 19992576; Write bytes: 413147136; Read time: 11200; Write time: 300788 04:03:11 INFO - TinderboxPrint: CPU usage
13.2% 04:03:11 INFO - TinderboxPrint: I/O read bytes / time
19,992,576 / 11,200 04:03:11 INFO - TinderboxPrint: I/O write bytes / time
413,147,136 / 300,788 04:03:11 INFO - TinderboxPrint: CPU idle
8,283.2 (86.8%) 04:03:11 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 04:03:11 INFO - TinderboxPrint: Swap in / out
0 / 0 04:03:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12394496; Read time: 0; Write time: 1540 04:03:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:03:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 17502208; Write bytes: 400752640; Read time: 10380; Write time: 299248 04:03:12 INFO - Running post-run listener: _upload_blobber_files 04:03:12 INFO - Blob upload gear active. 04:03:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:03:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:13 INFO - (blobuploader) - INFO - Done attempting. 04:03:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:03:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:03:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:14 INFO - (blobuploader) - INFO - Done attempting. 04:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:15 INFO - (blobuploader) - INFO - Done attempting. 04:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:21 INFO - (blobuploader) - INFO - Done attempting. 04:03:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:21 INFO - Return code: 0 04:03:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/263fc145f67e5c14358a8e54c0c3f714f3f3b19a170ecff8fa5442f3c48f647ce2bb5336ad78bf8aac2dd0890eac062d78e2657082eef3849a90641a8baa4dc9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c066f25dd66231b5a734090afd8ffddab262de74dcef2ebce2b68ca809f939fdfe056e6115270b4cf9fd3dfcf4fd49a836ee189686954f43a5d471c30f856d62", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ef70d37c4c903faf5efb5ac8cd553c5083f3eee92073fffe8ae12ec95fb713da179f0f7b2f4154933b930b9c73e644356172a1b3babf927e3b03a7b57d3aea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684187c9cb9bbb3ac0c5f64d59e485d1576ba36c0c25e655318b7b5be09b4ccfcb0eb1d53ce60a0024324c4bca7629f1e9f744830ac52abad9e550f7590c5fcf"} 04:03:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:21 INFO - Contents: 04:03:21 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/263fc145f67e5c14358a8e54c0c3f714f3f3b19a170ecff8fa5442f3c48f647ce2bb5336ad78bf8aac2dd0890eac062d78e2657082eef3849a90641a8baa4dc9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c066f25dd66231b5a734090afd8ffddab262de74dcef2ebce2b68ca809f939fdfe056e6115270b4cf9fd3dfcf4fd49a836ee189686954f43a5d471c30f856d62", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ef70d37c4c903faf5efb5ac8cd553c5083f3eee92073fffe8ae12ec95fb713da179f0f7b2f4154933b930b9c73e644356172a1b3babf927e3b03a7b57d3aea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684187c9cb9bbb3ac0c5f64d59e485d1576ba36c0c25e655318b7b5be09b4ccfcb0eb1d53ce60a0024324c4bca7629f1e9f744830ac52abad9e550f7590c5fcf"} 04:03:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:21 INFO - Copying logs to upload dir... 04:03:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.275569 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-03 04:03:21.923089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 04:03:21.926267) ========= 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-1507014692.838275-1376920695 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/263fc145f67e5c14358a8e54c0c3f714f3f3b19a170ecff8fa5442f3c48f647ce2bb5336ad78bf8aac2dd0890eac062d78e2657082eef3849a90641a8baa4dc9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c066f25dd66231b5a734090afd8ffddab262de74dcef2ebce2b68ca809f939fdfe056e6115270b4cf9fd3dfcf4fd49a836ee189686954f43a5d471c30f856d62", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ef70d37c4c903faf5efb5ac8cd553c5083f3eee92073fffe8ae12ec95fb713da179f0f7b2f4154933b930b9c73e644356172a1b3babf927e3b03a7b57d3aea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684187c9cb9bbb3ac0c5f64d59e485d1576ba36c0c25e655318b7b5be09b4ccfcb0eb1d53ce60a0024324c4bca7629f1e9f744830ac52abad9e550f7590c5fcf"} build_url:https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/S7Bgu-exQIOQMwslDlMfzQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/263fc145f67e5c14358a8e54c0c3f714f3f3b19a170ecff8fa5442f3c48f647ce2bb5336ad78bf8aac2dd0890eac062d78e2657082eef3849a90641a8baa4dc9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c066f25dd66231b5a734090afd8ffddab262de74dcef2ebce2b68ca809f939fdfe056e6115270b4cf9fd3dfcf4fd49a836ee189686954f43a5d471c30f856d62", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ef70d37c4c903faf5efb5ac8cd553c5083f3eee92073fffe8ae12ec95fb713da179f0f7b2f4154933b930b9c73e644356172a1b3babf927e3b03a7b57d3aea", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684187c9cb9bbb3ac0c5f64d59e485d1576ba36c0c25e655318b7b5be09b4ccfcb0eb1d53ce60a0024324c4bca7629f1e9f744830ac52abad9e550f7590c5fcf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 04:03:21.954047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:03:21.954328) ========= 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-1507014692.838275-1376920695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 04:03:22.037729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 04:03:22.038035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 04:03:22.038309) ========= ========= Total master_lag: 0.30 =========