builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1503662184.92 results: success (0) revision: b6b8e616de32af50c9a174006b3a7ed914130aa5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:24.924234) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:24.924651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:24.924951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:24.981925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:24.986195) ========= 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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 04:56:25-- 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% 46.2M=0s 2017-08-25 04:56:25 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122072 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.140831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.141141) ========= 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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016142 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:25.201789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 04:56:25.202091) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b6b8e616de32af50c9a174006b3a7ed914130aa5 --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 b6b8e616de32af50c9a174006b3a7ed914130aa5 --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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 04:56:25,328 truncating revision to first 12 chars 2017-08-25 04:56:25,328 Setting DEBUG logging. 2017-08-25 04:56:25,328 attempt 1/10 2017-08-25 04:56:25,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b6b8e616de32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 04:56:26,016 unpacking tar archive at: mozilla-central-b6b8e616de32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 04:56:26.210820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:26.211133) ========= script_repo_revision: b6b8e616de32af50c9a174006b3a7ed914130aa5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:26.211514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:26.211784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 04:56:26.227725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-25 04:56:26.228042) ========= /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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:26 INFO - MultiFileLogger online at 20170825 04:56:26 in /builds/slave/test 04:56:26 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 04:56:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:26 INFO - {'append_to_log': False, 04:56:26 INFO - 'base_work_dir': '/builds/slave/test', 04:56:26 INFO - 'blob_upload_branch': 'Firefox', 04:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:26 INFO - 'branch': 'Firefox', 04:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:26 INFO - 'code_coverage': False, 04:56:26 INFO - 'config_files': ('talos/linux_config.py',), 04:56:26 INFO - 'default_actions': ('clobber', 04:56:26 INFO - 'read-buildbot-config', 04:56:26 INFO - 'download-and-extract', 04:56:26 INFO - 'populate-webroot', 04:56:26 INFO - 'create-virtualenv', 04:56:26 INFO - 'install', 04:56:26 INFO - 'setup-mitmproxy', 04:56:26 INFO - 'run-tests'), 04:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:26 INFO - 'disable_ccov_upload': False, 04:56:26 INFO - 'download_minidump_stackwalk': True, 04:56:26 INFO - 'download_symbols': 'ondemand', 04:56:26 INFO - 'enable_stylo': False, 04:56:26 INFO - 'enable_webrender': False, 04:56:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:26 INFO - 'gecko_profile': False, 04:56:26 INFO - 'gecko_profile_interval': 0, 04:56:26 INFO - 'installer_path': 'installer.exe', 04:56:26 INFO - 'log_level': 'info', 04:56:26 INFO - 'log_name': 'talos', 04:56:26 INFO - 'log_to_console': True, 04:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:26 INFO - 'opt_config_files': (), 04:56:26 INFO - 'pip_index': False, 04:56:26 INFO - 'suite': 'dromaeojs-e10s', 04:56:26 INFO - 'system_bits': '32', 04:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:26 INFO - 'title': 'talos-linux64-ix-054', 04:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:26 INFO - 'use_talos_json': True, 04:56:26 INFO - 'verify': 'False', 04:56:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:26 INFO - 'work_dir': 'build'} 04:56:26 INFO - [mozharness: 2017-08-25 11:56:26.495822Z] Running clobber step. 04:56:26 INFO - Running pre-action listener: _resource_record_pre_action 04:56:26 INFO - Running main action method: clobber 04:56:26 INFO - rmtree: /builds/slave/test/build 04:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:27 INFO - Running post-action listener: _resource_record_post_action 04:56:27 INFO - [mozharness: 2017-08-25 11:56:27.524995Z] Finished clobber step (success) 04:56:27 INFO - [mozharness: 2017-08-25 11:56:27.525093Z] Running read-buildbot-config step. 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: read_buildbot_config 04:56:27 INFO - Using buildbot properties: 04:56:27 INFO - { 04:56:27 INFO - "project": "", 04:56:27 INFO - "product": "firefox", 04:56:27 INFO - "who": "archaeopteryx@coole-files.de", 04:56:27 INFO - "installer_path": "public/build/target.tar.bz2", 04:56:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 04:56:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 04:56:27 INFO - "stage_platform": "linux64-qr", 04:56:27 INFO - "basedir": "/builds/slave/test", 04:56:27 INFO - "buildnumber": 19, 04:56:27 INFO - "platform": "ubuntu64_hw_qr", 04:56:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:56:27 INFO - "slavebuilddir": "test", 04:56:27 INFO - "taskId": "IF41TI8bQhWv_YFPhakZKA", 04:56:27 INFO - "branch": "mozilla-central", 04:56:27 INFO - "script_repo_revision": "production", 04:56:27 INFO - "revision": "b6b8e616de32af50c9a174006b3a7ed914130aa5", 04:56:27 INFO - "slavename": "talos-linux64-ix-054", 04:56:27 INFO - "repo_path": "mozilla-central" 04:56:27 INFO - } 04:56:27 INFO - Finding installer, test and symbols from parent task. 04:56:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IF41TI8bQhWv_YFPhakZKA'}, attempt #1 04:56:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IF41TI8bQhWv_YFPhakZKA'}, attempt #1 04:56:28 INFO - Task dependencies: aS8yyg60SCGqrPCGhs8emA 04:56:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA'}, attempt #1 04:56:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json 04:56:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip 04:56:28 INFO - Running post-action listener: _resource_record_post_action 04:56:28 INFO - [mozharness: 2017-08-25 11:56:28.968663Z] Finished read-buildbot-config step (success) 04:56:28 INFO - [mozharness: 2017-08-25 11:56:28.968880Z] Running download-and-extract step. 04:56:28 INFO - Running pre-action listener: _resource_record_pre_action 04:56:28 INFO - Running main action method: download_and_extract 04:56:28 INFO - mkdir: /builds/slave/test/build/tests 04:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:28 INFO - trying https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json 04:56:28 INFO - Downloading https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:56:29 INFO - Downloaded 989 bytes. 04:56:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:56:29 INFO - Using the following test package requirements: 04:56:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:56:29 INFO - u'common': [u'target.common.tests.zip'], 04:56:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:56:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:56:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:56:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:56:29 INFO - u'mozbase': [u'target.common.tests.zip'], 04:56:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:56:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:56:29 INFO - u'web-platform': [u'target.common.tests.zip', 04:56:29 INFO - u'target.web-platform.tests.tar.gz'], 04:56:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:56:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip 04:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip into memory 04:56:30 INFO - Content-Length response header: 54980292 04:56:30 INFO - Bytes received: 54980292 04:56:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:56:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip 04:56:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:56:41 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.common.tests.zip into memory 04:56:42 INFO - Content-Length response header: 54980292 04:56:42 INFO - Bytes received: 54980292 04:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip 04:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.talos.tests.zip into memory 04:56:55 INFO - Content-Length response header: 14496611 04:56:55 INFO - Bytes received: 14496611 04:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:55 INFO - trying https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:56:56 INFO - Downloaded 61120310 bytes. 04:56:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:56 INFO - mkdir: /builds/slave/test/properties 04:56:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:56 INFO - Contents: 04:56:56 INFO - build_url:https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 04:56:56 INFO - Running post-action listener: _resource_record_post_action 04:56:56 INFO - Running post-action listener: find_tests_for_verification 04:56:56 INFO - Running post-action listener: set_extra_try_arguments 04:56:56 INFO - [mozharness: 2017-08-25 11:56:56.813262Z] Finished download-and-extract step (success) 04:56:56 INFO - [mozharness: 2017-08-25 11:56:56.813437Z] Running populate-webroot step. 04:56:56 INFO - Running pre-action listener: _resource_record_pre_action 04:56:56 INFO - Running main action method: populate_webroot 04:56:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'tests': ['damp', 'tps']}, 04:56:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['damp', 'tps']}, 04:56:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:56:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:56:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:56:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:56:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:56 INFO - 'ts_paint', 04:56:56 INFO - 'tpaint', 04:56:56 INFO - 'sessionrestore', 04:56:56 INFO - 'sessionrestore_many_windows', 04:56:56 INFO - 'sessionrestore_no_auto_restore', 04:56:56 INFO - 'tabpaint']}, 04:56:56 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['a11yr', 04:56:56 INFO - 'ts_paint', 04:56:56 INFO - 'tpaint', 04:56:56 INFO - 'sessionrestore', 04:56:56 INFO - 'sessionrestore_many_windows', 04:56:56 INFO - 'sessionrestore_no_auto_restore', 04:56:56 INFO - 'tabpaint']}, 04:56:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:56:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:56:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['bloom_basic_singleton']}, 04:56:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['bloom_basic']}, 04:56:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:56 INFO - 'tsvgr_opacity', 04:56:56 INFO - 'tart', 04:56:56 INFO - 'tscrollx', 04:56:56 INFO - 'tsvg_static']}, 04:56:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['tsvgx', 04:56:56 INFO - 'tsvgr_opacity', 04:56:56 INFO - 'tart', 04:56:56 INFO - 'tscrollx', 04:56:56 INFO - 'tsvg_static']}, 04:56:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:56:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--stylo'], 04:56:56 INFO - 'tests': ['tp5o']}, 04:56:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:56 INFO - 'talos_options': ['--mitmproxy', 04:56:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:56 INFO - '--firstNonBlankPaint'], 04:56:56 INFO - 'tests': ['tp6_google', 04:56:56 INFO - 'tp6_youtube', 04:56:56 INFO - 'tp6_amazon', 04:56:56 INFO - 'tp6_facebook']}, 04:56:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:56 INFO - 'talos_options': ['--stylo', 04:56:56 INFO - '--mitmproxy', 04:56:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:56 INFO - '--firstNonBlankPaint'], 04:56:56 INFO - 'tests': ['tp6_google', 04:56:56 INFO - 'tp6_youtube', 04:56:56 INFO - 'tp6_amazon', 04:56:56 INFO - 'tp6_facebook']}, 04:56:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:56 INFO - 'talos_options': ['--stylo', 04:56:56 INFO - '--stylo-threads=1', 04:56:56 INFO - '--mitmproxy', 04:56:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:56 INFO - '--firstNonBlankPaint'], 04:56:56 INFO - 'tests': ['tp6_google', 04:56:56 INFO - 'tp6_youtube', 04:56:56 INFO - 'tp6_amazon', 04:56:56 INFO - 'tp6_facebook']}, 04:56:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--xperf_path', 04:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:56 INFO - 'tests': ['tp5n']}, 04:56:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 04:56:56 INFO - 'talos_options': ['--stylo', 04:56:56 INFO - '--xperf_path', 04:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:56 INFO - 'tests': ['tp5n']}}} 04:56:56 INFO - Running post-action listener: _resource_record_post_action 04:56:56 INFO - [mozharness: 2017-08-25 11:56:56.828458Z] Finished populate-webroot step (success) 04:56:56 INFO - [mozharness: 2017-08-25 11:56:56.828548Z] Running create-virtualenv step. 04:56:56 INFO - Running pre-action listener: _resource_record_pre_action 04:56:56 INFO - Running main action method: create_virtualenv 04:56:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:56:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:56:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:57 INFO - Installing pip...............done. 04:56:57 INFO - Return code: 0 04:56:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:57 INFO - Reading from file tmpfile_stdout 04:56:57 INFO - Output received: 04:56:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:56:57 INFO - Using env: {'DISPLAY': ':0', 04:56:57 INFO - 'HOME': '/home/cltbld', 04:56:57 INFO - 'LANG': 'en_US.UTF-8', 04:56:57 INFO - 'LANGUAGE': 'en_US:en', 04:56:57 INFO - 'LOGNAME': 'cltbld', 04:56:57 INFO - 'MAIL': '/var/mail/cltbld', 04:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:57 INFO - 'MOZ_NO_REMOTE': '1', 04:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:57 INFO - 'NO_EM_RESTART': '1', 04:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:57 INFO - 'PWD': '/builds/slave/test', 04:56:57 INFO - 'SHELL': '/bin/bash', 04:56:57 INFO - 'SHLVL': '1', 04:56:57 INFO - 'TERM': 'linux', 04:56:57 INFO - 'TMOUT': '86400', 04:56:57 INFO - 'USER': 'cltbld', 04:56:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:57 INFO - '_': '/tools/buildbot/bin/python'} 04:56:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:56:59 INFO - Downloading/unpacking pip>=1.5 04:56:59 INFO - Running setup.py egg_info for package pip 04:56:59 INFO - warning: no files found matching 'pip/cacert.pem' 04:56:59 INFO - warning: no files found matching '*.html' under directory 'docs' 04:56:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:56:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:56:59 INFO - Installing collected packages: pip 04:56:59 INFO - Found existing installation: pip 1.1 04:56:59 INFO - Uninstalling pip: 04:56:59 INFO - Successfully uninstalled pip 04:56:59 INFO - Running setup.py install for pip 04:56:59 INFO - warning: no files found matching 'pip/cacert.pem' 04:56:59 INFO - warning: no files found matching '*.html' under directory 'docs' 04:56:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:56:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:56:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:56:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:56:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:56:59 INFO - Successfully installed pip 04:56:59 INFO - Cleaning up... 04:56:59 INFO - Return code: 0 04:56:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:56:59 INFO - Using env: {'DISPLAY': ':0', 04:56:59 INFO - 'HOME': '/home/cltbld', 04:56:59 INFO - 'LANG': 'en_US.UTF-8', 04:56:59 INFO - 'LANGUAGE': 'en_US:en', 04:56:59 INFO - 'LOGNAME': 'cltbld', 04:56:59 INFO - 'MAIL': '/var/mail/cltbld', 04:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:59 INFO - 'MOZ_NO_REMOTE': '1', 04:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:59 INFO - 'NO_EM_RESTART': '1', 04:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:59 INFO - 'PWD': '/builds/slave/test', 04:56:59 INFO - 'SHELL': '/bin/bash', 04:56:59 INFO - 'SHLVL': '1', 04:56:59 INFO - 'TERM': 'linux', 04:56:59 INFO - 'TMOUT': '86400', 04:56:59 INFO - 'USER': 'cltbld', 04:56:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:59 INFO - '_': '/tools/buildbot/bin/python'} 04:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:59 INFO - Downloading/unpacking psutil>=3.1.1 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:00 INFO - Installing collected packages: psutil 04:57:00 INFO - Running setup.py install for psutil 04:57:00 INFO - building 'psutil._psutil_linux' extension 04:57:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:57:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:57:00 INFO - building 'psutil._psutil_posix' extension 04:57:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:57:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:00 INFO - Successfully installed psutil 04:57:00 INFO - Cleaning up... 04:57:00 INFO - Return code: 0 04:57:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57: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')]} 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:57: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 mozsystemmonitor==0.3 04:57:00 INFO - Using env: {'DISPLAY': ':0', 04:57:00 INFO - 'HOME': '/home/cltbld', 04:57:00 INFO - 'LANG': 'en_US.UTF-8', 04:57:00 INFO - 'LANGUAGE': 'en_US:en', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MAIL': '/var/mail/cltbld', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SHLVL': '1', 04:57:00 INFO - 'TERM': 'linux', 04:57:00 INFO - 'TMOUT': '86400', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - '_': '/tools/buildbot/bin/python'} 04:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57: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 04:57: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 04:57: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 04:57: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 04:57:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:02 INFO - Installing collected packages: mozsystemmonitor 04:57:02 INFO - Running setup.py install for mozsystemmonitor 04:57:02 INFO - Successfully installed mozsystemmonitor 04:57:02 INFO - Cleaning up... 04:57:02 INFO - Return code: 0 04:57:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57: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', '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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:57: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 jsonschema==2.5.1 04:57:02 INFO - Using env: {'DISPLAY': ':0', 04:57:02 INFO - 'HOME': '/home/cltbld', 04:57:02 INFO - 'LANG': 'en_US.UTF-8', 04:57:02 INFO - 'LANGUAGE': 'en_US:en', 04:57:02 INFO - 'LOGNAME': 'cltbld', 04:57:02 INFO - 'MAIL': '/var/mail/cltbld', 04:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:02 INFO - 'MOZ_NO_REMOTE': '1', 04:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:02 INFO - 'NO_EM_RESTART': '1', 04:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:02 INFO - 'PWD': '/builds/slave/test', 04:57:02 INFO - 'SHELL': '/bin/bash', 04:57:02 INFO - 'SHLVL': '1', 04:57:02 INFO - 'TERM': 'linux', 04:57:02 INFO - 'TMOUT': '86400', 04:57:02 INFO - 'USER': 'cltbld', 04:57:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:02 INFO - '_': '/tools/buildbot/bin/python'} 04:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:57: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 04:57: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 04:57: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 04:57: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 04:57:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57: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 04:57: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 04:57: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 04:57: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 04:57:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:03 INFO - warning: no files found matching '*.txt' 04:57:03 INFO - no previously-included directories found matching 'build' 04:57:03 INFO - no previously-included directories found matching 'dist' 04:57:03 INFO - no previously-included directories found matching '.git*' 04:57:03 INFO - Installing collected packages: jsonschema, functools32 04:57:03 INFO - Running setup.py install for functools32 04:57:04 INFO - warning: no files found matching '*.txt' 04:57:04 INFO - no previously-included directories found matching 'build' 04:57:04 INFO - no previously-included directories found matching 'dist' 04:57:04 INFO - no previously-included directories found matching '.git*' 04:57:04 INFO - Successfully installed jsonschema functools32 04:57:04 INFO - Cleaning up... 04:57:04 INFO - Return code: 0 04:57:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57: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')]} 04:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:04 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:57:04 INFO - Using env: {'DISPLAY': ':0', 04:57:04 INFO - 'HOME': '/home/cltbld', 04:57:04 INFO - 'LANG': 'en_US.UTF-8', 04:57:04 INFO - 'LANGUAGE': 'en_US:en', 04:57:04 INFO - 'LOGNAME': 'cltbld', 04:57:04 INFO - 'MAIL': '/var/mail/cltbld', 04:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:04 INFO - 'MOZ_NO_REMOTE': '1', 04:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:04 INFO - 'NO_EM_RESTART': '1', 04:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:04 INFO - 'PWD': '/builds/slave/test', 04:57:04 INFO - 'SHELL': '/bin/bash', 04:57:04 INFO - 'SHLVL': '1', 04:57:04 INFO - 'TERM': 'linux', 04:57:04 INFO - 'TMOUT': '86400', 04:57:04 INFO - 'USER': 'cltbld', 04:57:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:04 INFO - '_': '/tools/buildbot/bin/python'} 04:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:57:04 INFO - Cleaning up... 04:57:04 INFO - Return code: 0 04:57:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57: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')]} 04:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:04 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:04 INFO - Using env: {'DISPLAY': ':0', 04:57:04 INFO - 'HOME': '/home/cltbld', 04:57:04 INFO - 'LANG': 'en_US.UTF-8', 04:57:04 INFO - 'LANGUAGE': 'en_US:en', 04:57:04 INFO - 'LOGNAME': 'cltbld', 04:57:04 INFO - 'MAIL': '/var/mail/cltbld', 04:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:04 INFO - 'MOZ_NO_REMOTE': '1', 04:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:04 INFO - 'NO_EM_RESTART': '1', 04:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:04 INFO - 'PWD': '/builds/slave/test', 04:57:04 INFO - 'SHELL': '/bin/bash', 04:57:04 INFO - 'SHLVL': '1', 04:57:04 INFO - 'TERM': 'linux', 04:57:04 INFO - 'TMOUT': '86400', 04:57:04 INFO - 'USER': 'cltbld', 04:57:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:04 INFO - '_': '/tools/buildbot/bin/python'} 04:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - Downloading docopt-0.6.1.tar.gz 04:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:06 INFO - Running setup.py install for blobuploader 04:57:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:06 INFO - Running setup.py install for requests 04:57:06 INFO - Running setup.py install for docopt 04:57:06 INFO - Successfully installed blobuploader requests docopt 04:57:06 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:06 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:06 INFO - Using env: {'DISPLAY': ':0', 04:57:06 INFO - 'HOME': '/home/cltbld', 04:57:06 INFO - 'LANG': 'en_US.UTF-8', 04:57:06 INFO - 'LANGUAGE': 'en_US:en', 04:57:06 INFO - 'LOGNAME': 'cltbld', 04:57:06 INFO - 'MAIL': '/var/mail/cltbld', 04:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:06 INFO - 'MOZ_NO_REMOTE': '1', 04:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:06 INFO - 'NO_EM_RESTART': '1', 04:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:06 INFO - 'PWD': '/builds/slave/test', 04:57:06 INFO - 'SHELL': '/bin/bash', 04:57:06 INFO - 'SHLVL': '1', 04:57:06 INFO - 'TERM': 'linux', 04:57:06 INFO - 'TMOUT': '86400', 04:57:06 INFO - 'USER': 'cltbld', 04:57:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:06 INFO - '_': '/tools/buildbot/bin/python'} 04:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:07 INFO - Running setup.py (path:/tmp/pip-FB7OQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:07 INFO - Running setup.py (path:/tmp/pip-op9vUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:07 INFO - Running setup.py (path:/tmp/pip-IWc4Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:07 INFO - Running setup.py (path:/tmp/pip-OUeuH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:07 INFO - Running setup.py (path:/tmp/pip-xZsnRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:07 INFO - Running setup.py (path:/tmp/pip-qOGfPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:07 INFO - Running setup.py (path:/tmp/pip-gVBrox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:07 INFO - Running setup.py (path:/tmp/pip-aBWwgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:07 INFO - Running setup.py (path:/tmp/pip-nhtGmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:07 INFO - Running setup.py (path:/tmp/pip-mczpln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:07 INFO - Running setup.py (path:/tmp/pip-tMhddI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:07 INFO - Running setup.py (path:/tmp/pip-fhPJ7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:07 INFO - Running setup.py (path:/tmp/pip-1zAAVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:07 INFO - Running setup.py (path:/tmp/pip-uWW_GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:08 INFO - Running setup.py (path:/tmp/pip-wPIpmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:08 INFO - Running setup.py (path:/tmp/pip-fylB_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:08 INFO - Running setup.py (path:/tmp/pip-bY__Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:08 INFO - Running setup.py install for manifestparser 04:57:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:08 INFO - Running setup.py install for mozcrash 04:57:08 INFO - Running setup.py install for mozdebug 04:57:08 INFO - Running setup.py install for mozdevice 04:57:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:08 INFO - Running setup.py install for mozfile 04:57:08 INFO - Running setup.py install for mozhttpd 04:57:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:08 INFO - Running setup.py install for mozinfo 04:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:08 INFO - Running setup.py install for mozInstall 04:57:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Running setup.py install for mozleak 04:57:09 INFO - Running setup.py install for mozlog 04:57:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Running setup.py install for moznetwork 04:57:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Running setup.py install for mozprocess 04:57:09 INFO - Running setup.py install for mozprofile 04:57:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Running setup.py install for mozrunner 04:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:09 INFO - Running setup.py install for mozscreenshot 04:57:09 INFO - Running setup.py install for moztest 04:57:09 INFO - Running setup.py install for mozversion 04:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:10 INFO - Cleaning up... 04:57:10 INFO - Return code: 0 04:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:10 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:10 INFO - Using env: {'DISPLAY': ':0', 04:57:10 INFO - 'HOME': '/home/cltbld', 04:57:10 INFO - 'LANG': 'en_US.UTF-8', 04:57:10 INFO - 'LANGUAGE': 'en_US:en', 04:57:10 INFO - 'LOGNAME': 'cltbld', 04:57:10 INFO - 'MAIL': '/var/mail/cltbld', 04:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:10 INFO - 'MOZ_NO_REMOTE': '1', 04:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:10 INFO - 'NO_EM_RESTART': '1', 04:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:10 INFO - 'PWD': '/builds/slave/test', 04:57:10 INFO - 'SHELL': '/bin/bash', 04:57:10 INFO - 'SHLVL': '1', 04:57:10 INFO - 'TERM': 'linux', 04:57:10 INFO - 'TMOUT': '86400', 04:57:10 INFO - 'USER': 'cltbld', 04:57:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:10 INFO - '_': '/tools/buildbot/bin/python'} 04:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:10 INFO - Running setup.py (path:/tmp/pip-g1B0Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:10 INFO - Running setup.py (path:/tmp/pip-589YKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:10 INFO - Running setup.py (path:/tmp/pip-eoakct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:10 INFO - Running setup.py (path:/tmp/pip-y2Nnqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:10 INFO - Running setup.py (path:/tmp/pip-JvlLtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:10 INFO - Running setup.py (path:/tmp/pip-KAE8jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:10 INFO - Running setup.py (path:/tmp/pip-h8rZJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:10 INFO - Running setup.py (path:/tmp/pip-gkzKzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:10 INFO - Running setup.py (path:/tmp/pip-QrknAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:10 INFO - Running setup.py (path:/tmp/pip-WmTnpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:10 INFO - Running setup.py (path:/tmp/pip-LVSLs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:11 INFO - Running setup.py (path:/tmp/pip-k2NpFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:11 INFO - Running setup.py (path:/tmp/pip-fb1wkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:11 INFO - Running setup.py (path:/tmp/pip-pFuN9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:11 INFO - Running setup.py (path:/tmp/pip-oqqTS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:11 INFO - Running setup.py (path:/tmp/pip-47KdJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:11 INFO - Running setup.py (path:/tmp/pip-3pQDW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:12 INFO - Downloading blessings-1.6.tar.gz 04:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:12 INFO - Installing collected packages: blessings 04:57:12 INFO - Running setup.py install for blessings 04:57:12 INFO - Successfully installed blessings 04:57:12 INFO - Cleaning up... 04:57:12 INFO - Return code: 0 04:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:13 INFO - Reading from file tmpfile_stdout 04:57:13 INFO - Current package versions: 04:57:13 INFO - argparse == 1.2.1 04:57:13 INFO - blessings == 1.6 04:57:13 INFO - blobuploader == 1.2.4 04:57:13 INFO - docopt == 0.6.1 04:57:13 INFO - functools32 == 3.2.3-2 04:57:13 INFO - jsonschema == 2.5.1 04:57:13 INFO - manifestparser == 1.1 04:57:13 INFO - mozInstall == 1.13 04:57:13 INFO - mozcrash == 1.0 04:57:13 INFO - mozdebug == 0.1 04:57:13 INFO - mozdevice == 0.51 04:57:13 INFO - mozfile == 1.2 04:57:13 INFO - mozhttpd == 0.7 04:57:13 INFO - mozinfo == 0.10 04:57:13 INFO - mozleak == 0.1 04:57:13 INFO - mozlog == 3.5 04:57:13 INFO - moznetwork == 0.27 04:57:13 INFO - mozprocess == 0.25 04:57:13 INFO - mozprofile == 0.28 04:57:13 INFO - mozrunner == 6.13 04:57:13 INFO - mozscreenshot == 0.1 04:57:13 INFO - mozsystemmonitor == 0.3 04:57:13 INFO - moztest == 0.8 04:57:13 INFO - mozversion == 1.4 04:57:13 INFO - psutil == 3.1.1 04:57:13 INFO - requests == 1.2.3 04:57:13 INFO - wsgiref == 0.1.2 04:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:13 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:13 INFO - Using env: {'DISPLAY': ':0', 04:57:13 INFO - 'HOME': '/home/cltbld', 04:57:13 INFO - 'LANG': 'en_US.UTF-8', 04:57:13 INFO - 'LANGUAGE': 'en_US:en', 04:57:13 INFO - 'LOGNAME': 'cltbld', 04:57:13 INFO - 'MAIL': '/var/mail/cltbld', 04:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:13 INFO - 'MOZ_NO_REMOTE': '1', 04:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:13 INFO - 'NO_EM_RESTART': '1', 04:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:13 INFO - 'PWD': '/builds/slave/test', 04:57:13 INFO - 'SHELL': '/bin/bash', 04:57:13 INFO - 'SHLVL': '1', 04:57:13 INFO - 'TERM': 'linux', 04:57:13 INFO - 'TMOUT': '86400', 04:57:13 INFO - 'USER': 'cltbld', 04:57:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:13 INFO - '_': '/tools/buildbot/bin/python'} 04:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:57:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:57:14 INFO - Installing collected packages: simplejson 04:57:14 INFO - Running setup.py install for simplejson 04:57:14 INFO - building 'simplejson._speedups' extension 04:57:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:57:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:57:15 INFO - Successfully installed simplejson 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 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 0x9da1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, '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': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:57:15 INFO - Using env: {'DISPLAY': ':0', 04:57:15 INFO - 'HOME': '/home/cltbld', 04:57:15 INFO - 'LANG': 'en_US.UTF-8', 04:57:15 INFO - 'LANGUAGE': 'en_US:en', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MAIL': '/var/mail/cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SHLVL': '1', 04:57:15 INFO - 'TERM': 'linux', 04:57:15 INFO - 'TMOUT': '86400', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - '_': '/tools/buildbot/bin/python'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Running post-action listener: _resource_record_post_action 04:57:15 INFO - Running post-action listener: _start_resource_monitoring 04:57:15 INFO - Starting resource monitoring. 04:57:15 INFO - [mozharness: 2017-08-25 11:57:15.739911Z] Finished create-virtualenv step (success) 04:57:15 INFO - [mozharness: 2017-08-25 11:57:15.740439Z] Running install step. 04:57:15 INFO - Running pre-action listener: _resource_record_pre_action 04:57:15 INFO - Running main action method: install 04:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:15 INFO - Reading from file tmpfile_stdout 04:57:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:16 INFO - Reading from file tmpfile_stdout 04:57:16 INFO - Output received: 04:57:16 INFO - Usage: mozinstall [options] installer 04:57:16 INFO - Options: 04:57:16 INFO - -h, --help show this help message and exit 04:57:16 INFO - -d DEST, --destination=DEST 04:57:16 INFO - Directory to install application into. [default: 04:57:16 INFO - "/builds/slave/test"] 04:57:16 INFO - --app=APP Application being installed. [default: firefox] 04:57:16 INFO - mkdir: /builds/slave/test/build/application 04:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:57:33 INFO - Reading from file tmpfile_stdout 04:57:33 INFO - Output received: 04:57:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:33 INFO - Running post-action listener: _resource_record_post_action 04:57:33 INFO - [mozharness: 2017-08-25 11:57:33.742059Z] Finished install step (success) 04:57:33 INFO - [mozharness: 2017-08-25 11:57:33.742344Z] Running setup-mitmproxy step. 04:57:33 INFO - Running pre-action listener: _resource_record_pre_action 04:57:33 INFO - Running main action method: setup_mitmproxy 04:57:33 INFO - Skipping: mitmproxy is not required 04:57:33 INFO - Running post-action listener: _resource_record_post_action 04:57:33 INFO - [mozharness: 2017-08-25 11:57:33.743562Z] Finished setup-mitmproxy step (success) 04:57:33 INFO - [mozharness: 2017-08-25 11:57:33.743783Z] Running run-tests step. 04:57:33 INFO - Running pre-action listener: _resource_record_pre_action 04:57:33 INFO - Running pre-action listener: _set_gcov_prefix 04:57:33 INFO - Running main action method: run_tests 04:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:33 INFO - Python 2.7.3 04:57:33 INFO - Return code: 0 04:57:33 INFO - grabbing minidump binary from tooltool 04:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:33 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 0xd46130>, '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 0xd47030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd474c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:57:33 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:57:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:57:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:33 INFO - Return code: 0 04:57:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:33 INFO - ENV: RUST_BACKTRACE is now full 04:57:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:33 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/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 04:57:33 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/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 04:57:33 INFO - Using env: {'DISPLAY': ':0', 04:57:33 INFO - 'HOME': '/home/cltbld', 04:57:33 INFO - 'LANG': 'en_US.UTF-8', 04:57:33 INFO - 'LANGUAGE': 'en_US:en', 04:57:33 INFO - 'LOGNAME': 'cltbld', 04:57:33 INFO - 'MAIL': '/var/mail/cltbld', 04:57:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:33 INFO - 'MOZ_ACCELERATED': '1', 04:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:33 INFO - 'MOZ_NO_REMOTE': '1', 04:57:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:33 INFO - 'MOZ_WEBRENDER': '1', 04:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:33 INFO - 'NO_EM_RESTART': '1', 04:57:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:33 INFO - 'PWD': '/builds/slave/test', 04:57:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:33 INFO - 'RUST_BACKTRACE': 'full', 04:57:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:33 INFO - 'SHELL': '/bin/bash', 04:57:33 INFO - 'SHLVL': '1', 04:57:33 INFO - 'TERM': 'linux', 04:57:33 INFO - 'TMOUT': '86400', 04:57:33 INFO - 'USER': 'cltbld', 04:57:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:33 INFO - '_': '/tools/buildbot/bin/python'} 04:57:33 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/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 04:57:34 INFO - mozversion application_buildid: 20170825111222 04:57:34 INFO - mozversion application_changeset: b6b8e616de32af50c9a174006b3a7ed914130aa5 04:57:34 INFO - mozversion application_display_name: Nightly 04:57:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:34 INFO - mozversion application_name: Firefox 04:57:34 INFO - mozversion application_remotingname: firefox 04:57:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:34 INFO - mozversion application_vendor: Mozilla 04:57:34 INFO - mozversion application_version: 57.0a1 04:57:34 INFO - mozversion platform_buildid: 20170825111222 04:57:34 INFO - mozversion platform_changeset: b6b8e616de32af50c9a174006b3a7ed914130aa5 04:57:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:34 INFO - mozversion platform_version: 57.0a1 04:57:34 INFO - using testdate: 1503662254 04:57:34 INFO - actual date: 1503662254 04:57:34 INFO - starting webserver on 'localhost:55612' 04:57:34 INFO - SUITE-START | Running 2 tests 04:57:34 INFO - TEST-START | dromaeo_css 04:57:34 INFO - Initialising browser for dromaeo_css test... 04:57:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55612/getInfo.html -profile /tmp/tmp9zg8E2/profile 04:57:34 INFO - TEST-INFO | started process 13261 (/builds/slave/test/build/application/firefox/firefox http://localhost:55612/getInfo.html) 04:57:40 INFO - TEST-INFO | 13261: exit 0 04:57:40 INFO - Browser initialized. 04:57:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:40 INFO - Using env: {'DISPLAY': ':0', 04:57:40 INFO - 'HOME': '/home/cltbld', 04:57:40 INFO - 'JSGC_DISABLE_POISONING': '1', 04:57:40 INFO - 'LANG': 'en_US.UTF-8', 04:57:40 INFO - 'LANGUAGE': 'en_US:en', 04:57:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:57:40 INFO - 'LOGNAME': 'cltbld', 04:57:40 INFO - 'MAIL': '/var/mail/cltbld', 04:57:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:40 INFO - 'MOZ_ACCELERATED': '1', 04:57:40 INFO - 'MOZ_CRASHREPORTER': '1', 04:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:57:40 INFO - 'MOZ_NO_REMOTE': '1', 04:57:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:40 INFO - 'MOZ_WEBRENDER': '1', 04:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:40 INFO - 'NO_EM_RESTART': '1', 04:57:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:40 INFO - 'PWD': '/builds/slave/test', 04:57:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:40 INFO - 'RUST_BACKTRACE': 'full', 04:57:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:40 INFO - 'SHELL': '/bin/bash', 04:57:40 INFO - 'SHLVL': '1', 04:57:40 INFO - 'TERM': 'linux', 04:57:40 INFO - 'TMOUT': '86400', 04:57:40 INFO - 'USER': 'cltbld', 04:57:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 04:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:40 INFO - '_': '/tools/buildbot/bin/python'} 04:57:40 INFO - TEST-INFO | started process 13442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9zg8E2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:41 INFO - PID 13442 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:57:41 INFO - PID 13442 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:57:41 INFO - PID 13442 | 04:57:41 INFO - PID 13442 | (/builds/slave/test/build/application/firefox/firefox:13502): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:57:41 INFO - PID 13442 | 04:57:42 INFO - PID 13442 | 04:57:42 INFO - PID 13442 | (/builds/slave/test/build/application/firefox/firefox:13559): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:57:42 INFO - PID 13442 | 04:57:42 INFO - PID 13442 | __metrics Screen width/height:1600/1200 04:57:42 INFO - PID 13442 | colorDepth:24 04:57:42 INFO - PID 13442 | Browser inner width/height: 1024/768 04:57:42 INFO - PID 13442 | __metrics 04:57:52 INFO - PID 13442 | RSS: Main: 200400896 04:57:52 INFO - PID 13442 | 04:57:55 INFO - PID 13442 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:00:50 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55612/tests/dromaeo/cssquery-ext.html) 05:00:52 INFO - PID 13442 | RSS: Main: 212332544 05:00:52 INFO - PID 13442 | 05:03:54 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-ext.html (next: http://localhost:55612/tests/dromaeo/cssquery-jquery.html) 05:03:55 INFO - PID 13442 | RSS: Main: 209006592 05:03:55 INFO - PID 13442 | 05:06:57 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55612/tests/dromaeo/cssquery-mootools.html) 05:06:57 INFO - PID 13442 | RSS: Main: 211857408 05:06:57 INFO - PID 13442 | 05:10:00 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55612/tests/dromaeo/cssquery-prototype.html) 05:10:00 INFO - PID 13442 | RSS: Main: 212578304 05:10:00 INFO - PID 13442 | 05:13:04 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55612/tests/dromaeo/cssquery-yui.html) 05:13:04 INFO - PID 13442 | RSS: Main: 213909504 05:13:04 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | Cycle 1(1): loaded http://localhost:55612/tests/dromaeo/cssquery-yui.html (next: http://localhost:55612/tests/dromaeo/cssquery-dojo.html) 05:16:07 INFO - PID 13442 | RSS: Main: 211013632 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | __start_tp_report 05:16:07 INFO - PID 13442 | _x_x_mozilla_page_load 05:16:07 INFO - PID 13442 | _x_x_mozilla_page_load_details 05:16:07 INFO - PID 13442 | |i|pagename|runs| 05:16:07 INFO - PID 13442 | |0;dojo.html;3313.6189338226113;3319.41910165721;3333.399988002159;3333.833308334584;3340.4488259437194;6150.200473938393;6219.7512099516025;6243.157173781538;6269.937300626998;6305.8108256752375;6123.050927106306;6233.532485063615;6260.530460215491;6261.624302541851;6264.780732674358;5678.205051292823;5692.203091567194;5692.800751973682;5693.544516438696;5716.28546431696;5763.827085187451;5789.334226563936;5803.564732645069;5814.156947242668;5846.824595262149;5706.686132262724;5746.655200687951;5767.538596912237;5802.738876750535;5832.6792026438525;94.86303517213896;5604.831855044315;5657.038303488417;5838.241028666267;5846.9707651461895;5609.943900560983;5668.149777533362;5685.346185188715;5721.141828725683;5728.570357223225;6139.355367686373;6230.190075290228;6252.468540174091;6289.7169627366875;6338.524610654219;6635.336466353374;6674.365935236145;6690.83272918181;6798.116244888182;6803.285655006202;6721.1598550181225;6723.697433615499;6732.798016059526;6831.726730930757;6832.111825462708;5983.611065280743;6197.380261973857;6197.504199664016;6282.403171698681;6345.746170153235;6765.086713293741;6787.830304242335;6822.317768223138;6853;6864.656767161622;6479.060536222221;6506.739730410731;6507.056476810836;6513.73945042193;6563.868722625521;6537.411632952962;6562.212534495796;6618.86762264752;6642.036904648799;6648.16897887764;6672.366125218194;6686.933130668728;6698.799036028927;6756.966215168893;6770.187577490733;6665.666716664147;6679.131712877295;6730.629815360105;6751.25736169021;6753.662316884136;5219.791208351699;5282.656627319212;5292.629515933848;5352.143657014859;5362.785488580491;4686.5782079613;4716.976415117971;4722.268048452495;4725.905481890343;4740.19416699162;5813.447722466359;5868.94131058684;5912.645241285537;5942.138389933435;5965.582409231312;6709.36261055199;6751.4261287790105;6780.966095169492;6836.248012718597;6839.760608378683;5664.150377443334;5790.189373487715;5804.187413762077;5817.156512305776;5908.793192238251;5693.772249110072;5698.686572238484;5709.942900571024;5710.685912274865;5712.857178570569;6436.645984470805;6444.258910225384;6456.0961465394885;6466.870662586722;6663.13379260693;6666.100076489805;6681.164854393103;6726.529142959946;6741.696623652046;6779.661016949231;6262.5929314594405;6526.184226971629;6678.165229346332;6683.365080317362;6704.296048914794;6623.801285961429;6656.83357916056;6657.201135863534;6672.299408562031;6753.831154220988;6452.935470645233;6575.473962083118;6579.243387010555;6587.4071333580205;6772.695228714621;6461.483081353386;6531.2489063756375;6544.934550654432;6593.472522198309;6596.934030659824;6580.76967306142;6586.407223349922;6601.900971485527;6606.306337834651;6609.537332386687;6284.811455656338;6337.683115844097;6431.742730290736;6455.515836312202;6550;6442.323556026738;6457.61254324742;6499.285078641251;6504.9674751625935;6521.804345869631;6307.400796924285;6312.495000400048;6312.621242725451;6342.936570634234;6344.175257216532 05:16:07 INFO - PID 13442 | |1;ext.html;755.4560716284274;826.404988408346;850.5704619167324;852.122314016563;1113.5768408004958;28541.714582854165;29171;29190.708092919092;37809.24381512368;39208;38391.61608383915;38864.22271554567;38866;38890.80554597223;38891.611083889155;5632.690202038886;7472.17806041335;7605.239476052406;7608.505447145945;7609.619519024054;5737.655740655553;7429.777106686808;7563.394928405714;7590.506617069873;7620.390368770512;7580.469367144302;7596.696132154707;7612.7335543255995;7630.2369763023535;7632.465727399084;7532.510386824839;7593;7600.543967361976;7610.6194690265265;7627.733029343946;7322.377597904185;7340.155882073576;7388.556686598821;7389.334959853585;7408.666610002563;34934.47598286028;35006.47490287648;35024.29951400957;35118.82440587806;35118.82440587806;3375.7468189885612;3403.914902127442;3416.299658569987;3417.4361230396953;3419.5212670226188;29342.266443338875;29387;29448.263793405124;29461.26346841346;29476.410471790445;4854.514548545152;4995.550400463976;5023.372078490189;5048.192289233742;5143.614228932807;181604;182147;182302;182637;183588.08205959018;44663.77668111639;44713.776431117636;45010.54989450129;45064;45181.09637807225;46290.5370946293;46791.766041169576;49190.75404623026;50262;50350;15461.304241309168;15586.376544938303;15612.3755049799;15620.609484762972;15632.2183890805;12721.872781272254;12760.234385936874;12763.106582539132;12764.297963611905;12771;13823.654408639663;14043.50847720325;14101.576952691436;14120.71758564823;14159.504417345344;5485.917711234335;5505.9724701376235;5648.604597678123;5695.572832037614;5718.942810571924;965.7875267441152;968.3463662028103;974.8342781727123;992.2161492421051;997.3915911294105;20827;20849.58300833975;21169.78830211678;21316.147354105662;21680.674789878165;1054.2093429927554;1069.6470164845582;1077.9892201078046;1078.229066217658;1093.5133865429807;11324.716882078013;11492.138089643311;11508.136889733303;11563.6530904073;11611.303321800719;228564;228669;229926;230265;230270;47834.521654783704;47969;48263.27605085926;48416.27375589369;48493.757531212825;1365.6244532753572;1407.0713329202881;1413.5123382433044;1417.3905220755175;1421.4953691439391;20027.19891204394;20033.79966200319;20259.29092481756;20371.79628203699;20458.38624841257;34035;34147.14632134217;34287.65712342845;34289.48565771466;34339.31321373609;191822;194528;194599;194915;194991;27870.16389508318;28435.43129137447;31321.216969575944;31459.52810707887;31586.210344741565;39783.40324895071;40020.1995960085;40198.79900600478;40221.396679049256;40585.1882962345;28886;29103.41793164167;29331.266718332212;29467.85266073656;29622.851885740434;29144.27139321534;29520.557191642572;29704.10887673373;29749.392889844927;30233.546496803006;32262.516062259554;32335.514967275038;32470.837645811618;32527.512087318235;32877.50683739698;28973.420531589672;29147.562786557795;29215;29313.56029659514;29522.704772952853;22291.665625015314;22343.9429550254;22362.552748945254;22454.663180051986;22634 05:16:07 INFO - PID 13442 | |2;jquery.html;562.7523889488627;567.9602427830051;570.3156212544947;572.2703552969963;575.8157389635317;21282.57434851304;22212.666809997863;22326.88836555819;22335.218267360626;22368.10527578895;23282.18512352068;25858.224253272387;25919;25939.481210375827;26077.60883586748;6541.705623246965;6616.702248398834;6631.568948018387;6648.7672931447405;6715.160604924385;6537.803865884031;6567.638779867106;6571.67141642916;6582.308857569958;6601.2738598754095;5869.9706501467435;6446.774362897299;6480.837979050514;6498.220213574377;6507.6420796856155;6426.036094585803;6472.644004579746;6476.4818814494965;6481.222253329607;6492.3183065777885;5958.940410595882;5966.045432730785;5969.194158788551;5972.462478376923;5974.894644490783;28000.299992500146;28535.571966420313;28824.85587572049;29157.41685166306;29489;1997.0414201183514;2056.907439165226;2069.5757369739167;2072.067569593689;2076.1487790006026;18871.905640471847;19562;19564.902175489173;19583.314583989635;19601.1179496923;2338.181636427254;2369.5497855407416;2395.9098610132346;2415.855048697084;2468.2841975826987;136018;140390;140638.29680851632;141571.29214353964;141951;13926.512572060132;14484.275786210648;14497.927510362591;14773.335199915815;15136.091834489745;22605.43486412853;22671.773282267295;22676.546469070527;22712.545749084926;22745.431364216027;9778.853317200248;9889.901100988898;10067.446290454096;10090;10173.898261017295;9196.816063678689;9197.908020919838;9218.124278193562;9265.212456941235;9464.290178236659;8426.283765879969;8660.220580147818;8820.382573219813;9063.728088157366;9134.543272836465;2623.22614828626;2651.6022596610665;2689.784817214618;2740.397112635217;2835.6597208335133;915.7435917942987;930.9115634014893;947.7583216279804;958.4393130018877;963.7735132243918;17567;17627.55931101733;17859.28562857471;18517.44447666572;18598.16308266131;1003.0521157506232;1016.761061150629;1020.1430798129607;1027.3784360461962;1029.7888932768765;10384.221183411275;10386.688399348031;10394.16846652266;10524.947505249567;10729;473797;478282;480699;482241;491030;112089.43955280172;113847.43076284566;114984;115044;117984;1093.2238110941162;1094.392612100276;1113.059464752283;1115.0466351269547;1117.580907159815;16431.424900128437;16495.422660206834;16499.67000659956;16513.256903439134;16638.750418743486;52064;55095;55808;55964.720176398856;56171.43828561662;66069.33930660631;66926.33073669396;67026.66486667536;67085;71224.9316260267;14265.71468570602;14701;14739.852601474277;14801.777973330194;14820.184889831164;22936.311910642708;23031;23164.420889477897;23305.18431854877;23369.298921032398;17214.139293035547;17334.82665173332;17344.653106938043;17490.82509174943;17614.383496577557;16167.110808905623;16629.91685041567;16646.833531665012;16992.98042117477;17117.14414279256;16377.263023163749;16670.58323541921;16966.915165424092;17020.234089465757;17049.232784524975;13842.65393365174;14445.06107103035;14508.34712437964;14531.273436328353;14538;18060.367887123888;18100.818991809912;18140.274389024293;18208.271669133086;18241.270349186416 05:16:07 INFO - PID 13442 | |3;mootools.html;1282.2498838179665;1315.6184706435133;1339.1028011232477;1341.7115320206153;1356.2133962301866;14411.423543058278;14924;15008.699826003472;15014.24928753562;15024.323905424255;14513.20177390243;15495;15499;15502.30239639216;15519.991200571954;2649.244965184923;2691.1119330620945;2718.592211168321;2723.128598848369;2724.346156922334;2521.6343630173615;2533.4173140177772;2540.0982651158756;2591.041314713549;2607.8304910180873;2621.908233211838;2662.4142688608476;2669.919902402931;2670.505956398063;2679.6382488364115;2665.3070201747587;2669.7997650176317;2680.6783186017706;2681.9061332853453;2688.3144798076364;2601.9219423417326;2636.2882021853993;2649.973500264992;2650.483155784623;2691.9461610767676;14498.855011449856;14578.854211457856;14587.051841630366;14613.561593152222;14694.926525367411;7657;7910.2880740733035;7925.088614809255;7939;7942.483738556975;5322.893542129135;5401.891962160774;5467.45325467454;5511.559075274008;5520.696361700145;1869.9158537865828;1872.140201170328;1891.297831951241;1893.5360836594984;1911.923523059076;25186.748132518624;25437.745622543724;25498.107566235092;25518.23445296644;25525.10662126835;6472.644004579794;6481.222253329631;6526.543141980016;6636.568623039487;6650.401463868178;16979.575510612332;16980.32078716862;17061.061641609584;17111.657766844593;17136.828631713524;7477.85044299111;7606.04924384452;7624.313811756969;7661.387089032864;7672.271134242238;6950.860982780316;7020.297970203041;7106.786796396116;7135.393491553276;7230;5012.548870601663;5123.3339665843205;5135.075686376488;5142.177251639794;5233.71214583194;1357.9456821727217;1363.2638375277238;1450.7678771396527;1487.5537338798317;1517.1124891938118;842.8904242448442;850.6980022092192;863.2834747159842;877.2105105405186;877.9736607901773;7227.602481863548;7365.263473652699;7478.70085196586;7503.09962804467;7607.581583012877;922.6125027488471;944.6457578408097;945.3099237556622;948.4025064209504;951.6574033347989;4800.399950006249;4930.679505832181;4943.209086546135;4946.208606622923;4968;20230.19079236814;20452.181912723623;21199;21236.25673101434;21272.36182914515;20027;20505.2823151189;20667.06998185085;21260.681089783666;21292;10274.178065754722;10640.946795266129;10644.680659580225;10904.672859814218;10945.781084378426;8215.917840821754;8447.746567602982;8579.056303806452;8586;8599.484030958163;17376.478705638852;17752.822471775118;17960.281588736303;17961.101944902963;18097.185626647097;16894.66210675804;18041.548961276072;18066.187021584323;18427.447176584723;18649.067546622344;13553.322333883463;13569.710877466625;13695.520656776966;13797.931010344884;13809.102408343426;13592.184468931895;13832.930835346162;13862.792058119338;13867.722645547234;13896.58310250694;8560.315174785877;10398.428086455015;11284;11555.133364997491;11738;11000.449977500934;11132.88867111351;11144.275622084539;11231.438428078727;11275;9225.538723063686;9236.769080773034;9238.584263708015;9305;9345.439273643604;6418.486521078209;6502.0246962955935;6530.8367290818105;6565.916623757218;6628.53600247978;6766.221884483348;6789.796306110825;6957.547759395623;6977.197622273504;7040.190378106583 05:16:07 INFO - PID 13442 | |4;prototype.html;491.11599121581156;499.1962939667133;515.9871003224919;517.7256054291225;527.2776296473832;6196.473299769519;6217.906731399022;6233.9816447759595;6265.9060114098265;6289.339619339972;6084.087386891957;6143.416375444337;6145.108959200913;6156.907646385296;6250.156228909096;5066.949330506684;5067.214581739827;5095.796168153288;5113.309703190059;5136.152534831767;4697.389339385875;4919.2129259318335;4925.497723194442;5013.771625951628;5107.131787596099;4846.757662116897;4895;4900.117978763821;4901.142300097486;4928.186849169882;4825.951740482586;4870.878228044292;4892.168331383637;4897.114610874821;4947.480514545975;4372.737635741865;4374.6062854342945;4384.596928982727;4385.978070109661;4423.314386270134;6054.757809687607;6100.755969761204;6114.541409394314;6125.499252683121;6184.9176394130845;5530.72793257553;5550.72246387679;5556.444355564452;5604.70207215044;5630.493255607015;6399.488040956712;6413.8396540086405;6452.580582262138;6461.289258181643;6524.641144737037;4751.952480475185;4759.309900064472;4760.071786001731;4763.285507173917;4774.259989701602;6507.414332710032;6672.7330906764155;6681.632510211985;6794.626295553742;6919.135108111486;4838.153323168502;4900.57883213864;4972;4973.353464049723;4986.426560945538;5004.824831130893;5025.572826309732;5068.983954547039;5076.568491678248;5079.517445842639;5529.585281103853;5616.466435688603;5634.971825140848;5649.717514124277;5686.346070201897;6487.318831522716;6488.545801793924;6569.310222426672;6584.275729669733;6621.9337806621315;1722.8191039940625;1762.4007837335369;1763.982360176382;1773.4590949760188;1776.7601373814628;967.8741763570831;1222.413241644016;1223.2110288863812;1236.2458900070949;1239.7458521003173;5805.941940580625;5873.119032145212;5894.970525147432;5905.4685078343155;5908.438698323653;6736.8989465158065;6740.629265390353;6744.527883048139;6820.897686534706;6822.181338239443;5778.855528611818;5825.7378417971295;5851.882962340729;5885.61743486672;5904.291485021825;3572.321258960841;3599.1182160370354;3614.566252049718;3615.168511242429;3640.4357324614725;6679.532432729662;6680.164979377578;6691.698873550702;6708.463322934153;6717.1267735194115;6751;6848.9795510324575;6879.58722476653;6922.826929326807;6957.234704182536;6583.308752581006;6634.402903738686;6654.534182607268;6678.5307232408795;6696.63168525726;6676;6741.157355330583;6760.492963027891;6760.966195168992;6781.6097699970405;6023.397660233942;6486.4486518646445;6524.380183882524;6615.702293396713;6655.73377064912;6603.471722262111;6652.301508341748;6655.23464801554;6687.531872769054;6704.329567043256;4894.51054894522;4904.308013735255;4917.852464426073;4954.232094025432;5019.121653710513;6543.149390579194;6603.80188594343;6707.5304728668525;6769.289224631343;6848.623325717133;6411.903821442776;6415.839604009937;6451.1936007999;6456.54804163704;6506.739730410731;6419.743210271724;6427.389398007182;6523.3150519194805;6558.081868538504;6617.172853393326;6343.986606362126;6370.26741924666;6372.872542549216;6445.70994305248;6455.289918108911;6541;6550.050242714875;6554.016897465418;6555.836104097436;6629.801105966829;6235.657038862724;6343.460805831556;6362.204724409449;6386.16979792624;6409.487241020801 05:16:07 INFO - PID 13442 | |5;yui.html;884.226301985762;892.8571428571428;896.6816780043084;915.3958387464274;916.1708653668428;18239;19420;19479.22083116677;19495.512612184702;19497.3175938842;17349.219285132167;17425;18144.18351174197;18228.362007329746;18396.35612753554;947.5688561704425;960.8558716192592;961.3414810854587;961.6586111930269;967.1585720423207;950;952.8951815300311;959.8656188133667;966.077396086739;967.351874244258;905.5608030105426;980.0983095552074;984.9704508864745;989.5448093876826;995.8257304971637;983.5623147699276;988.3229987458614;991.5736233419626;992.6972273456593;993.1905497019978;715.8282012317059;722.4076257468878;724.2106104346235;724.4602770935634;727.4871215792854;17641.117944102873;17760.023198724066;17878.91060544702;17913.462596122135;19035.61928761417;19928.202871885107;20060.784196108973;20264.898675506676;20531.89734051335;20555.280565180146;16533.090680012596;16768.161591920478;16952.83047169537;16968.3212671493;16986.15069246545;3658.9451158232646;3660.1032746976894;3671.173985853162;3671.504346913159;3672.2471893262086;117907;123378.38310808389;123946;124326.37836810759;125622;16304.836951630568;16607.83392166063;16616.335346586002;16622.66754664924;16628.750568741478;28292.575611365846;29115.85442072776;29289.414211716074;29297.267568310537;29362.853185734362;8187.467814592152;8754.518501482353;8773.034966153718;8799.208071273617;8801.47191168532;4163.208990291835;4208.684348673862;4252.277112890816;4257.978710106491;4300.677449191323;4992.72540010303;5042;5095.668781529189;5129.743512824344;5139.820106296262;1075.4300220882944;1089.1831126655009;1096.2819353323587;1103.6688993301977;1108.9223754337281;660.7687309441657;680.1464162476061;684.4216636941776;685.9931400686029;689.5380095336137;10480;10658.626948056935;10721.517531711092;10905.309677000077;10972.506237219344;650.4373716735084;659.9769008084694;674.7908148473989;677.2888467109515;680.2041611314773;4794.879603788371;5016.046951079356;5979.4917432018765;6213.285472170668;6336.58812177207;108319;109106;111997;112440.43779781212;112894;98491.50754246327;98770;100366;100857.49571252243;102480.97519024863;87677;88078;88789.55605222062;89923.55038224637;91280.54359728291;12044.939775301067;12205.389730513261;12207.816882746589;12275.69310767238;12311.13822032485;39897.80051099726;40122.59877401189;40593;41618;42295.5770442304;50751;51285.23072153846;52274.21588676249;53098;53283.20075198953;13787.172769633855;17680.646387072444;18062.458126256235;18177.545561361072;18201.81798182001;16919.407820726214;17224.397146099825;18674.25302987865;20552.17791288332;20962.371128866158;18719.719204211677;18766.718499222796;18968.905155474135;19039;19068;17477.912610436866;17481.47555573335;17490.12549372501;17504.73742893883;17705.911470442566;16653.834231603672;16796.328146874475;16969.406070787463;16972.575685607466;17260.82739172592;12168.478940132483;12386.75226495447;12425.502979880703;12459.875401245872;12572.685682858002;13933;13997.720045599235;14001.22993235382;14153.221572813594;14358.641033974234 05:16:07 INFO - PID 13442 | __end_tp_report 05:16:07 INFO - PID 13442 | __start_cc_report 05:16:07 INFO - PID 13442 | _x_x_mozilla_cycle_collect,359 05:16:07 INFO - PID 13442 | __end_cc_report 05:16:07 INFO - PID 13442 | __startTimestamp1503663367264__endTimestamp 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | ------- Summary: start ------- 05:16:07 INFO - PID 13442 | Number of tests: 6 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#0] dojo.html Cycles:165 Average:6129.78 Median:6431.74 stddev:848.40 (13.2%) stddev-sans-first:821.73 05:16:07 INFO - PID 13442 | Values: 3313.6 3319.4 3333.4 3333.8 3340.4 6150.2 6219.8 6243.2 6269.9 6305.8 6123.1 6233.5 6260.5 6261.6 6264.8 5678.2 5692.2 5692.8 5693.5 5716.3 5763.8 5789.3 5803.6 5814.2 5846.8 5706.7 5746.7 5767.5 5802.7 5832.7 94.9 5604.8 5657.0 5838.2 5847.0 5609.9 5668.1 5685.3 5721.1 5728.6 6139.4 6230.2 6252.5 6289.7 6338.5 6635.3 6674.4 6690.8 6798.1 6803.3 6721.2 6723.7 6732.8 6831.7 6832.1 5983.6 6197.4 6197.5 6282.4 6345.7 6765.1 6787.8 6822.3 6853.0 6864.7 6479.1 6506.7 6507.1 6513.7 6563.9 6537.4 6562.2 6618.9 6642.0 6648.2 6672.4 6686.9 6698.8 6757.0 6770.2 6665.7 6679.1 6730.6 6751.3 6753.7 5219.8 5282.7 5292.6 5352.1 5362.8 4686.6 4717.0 4722.3 4725.9 4740.2 5813.4 5868.9 5912.6 5942.1 5965.6 6709.4 6751.4 6781.0 6836.2 6839.8 5664.2 5790.2 5804.2 5817.2 5908.8 5693.8 5698.7 5709.9 5710.7 5712.9 6436.6 6444.3 6456.1 6466.9 6663.1 6666.1 6681.2 6726.5 6741.7 6779.7 6262.6 6526.2 6678.2 6683.4 6704.3 6623.8 6656.8 6657.2 6672.3 6753.8 6452.9 6575.5 6579.2 6587.4 6772.7 6461.5 6531.2 6544.9 6593.5 6596.9 6580.8 6586.4 6601.9 6606.3 6609.5 6284.8 6337.7 6431.7 6455.5 6550.0 6442.3 6457.6 6499.3 6505.0 6521.8 6307.4 6312.5 6312.6 6342.9 6344.2 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#1] ext.html Cycles:180 Average:35614.23 Median:32403.18 stddev:52641.41 (162.5%) stddev-sans-first:52724.01 05:16:07 INFO - PID 13442 | Values: 755.5 826.4 850.6 852.1 1113.6 28541.7 29171.0 29190.7 37809.2 39208.0 38391.6 38864.2 38866.0 38890.8 38891.6 5632.7 7472.2 7605.2 7608.5 7609.6 5737.7 7429.8 7563.4 7590.5 7620.4 7580.5 7596.7 7612.7 7630.2 7632.5 7532.5 7593.0 7600.5 7610.6 7627.7 7322.4 7340.2 7388.6 7389.3 7408.7 34934.5 35006.5 35024.3 35118.8 35118.8 3375.7 3403.9 3416.3 3417.4 3419.5 29342.3 29387.0 29448.3 29461.3 29476.4 4854.5 4995.6 5023.4 5048.2 5143.6 181604.0 182147.0 182302.0 182637.0 183588.1 44663.8 44713.8 45010.5 45064.0 45181.1 46290.5 46791.8 49190.8 50262.0 50350.0 15461.3 15586.4 15612.4 15620.6 15632.2 12721.9 12760.2 12763.1 12764.3 12771.0 13823.7 14043.5 14101.6 14120.7 14159.5 5485.9 5506.0 5648.6 5695.6 5718.9 965.8 968.3 974.8 992.2 997.4 20827.0 20849.6 21169.8 21316.1 21680.7 1054.2 1069.6 1078.0 1078.2 1093.5 11324.7 11492.1 11508.1 11563.7 11611.3 228564.0 228669.0 229926.0 230265.0 230270.0 47834.5 47969.0 48263.3 48416.3 48493.8 1365.6 1407.1 1413.5 1417.4 1421.5 20027.2 20033.8 20259.3 20371.8 20458.4 34035.0 34147.1 34287.7 34289.5 34339.3 191822.0 194528.0 194599.0 194915.0 194991.0 27870.2 28435.4 31321.2 31459.5 31586.2 39783.4 40020.2 40198.8 40221.4 40585.2 28886.0 29103.4 29331.3 29467.9 29622.9 29144.3 29520.6 29704.1 29749.4 30233.5 32262.5 32335.5 32470.8 32527.5 32877.5 28973.4 29147.6 29215.0 29313.6 29522.7 22291.7 22343.9 22362.6 22454.7 22634.0 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#2] jquery.html Cycles:180 Average:34139.06 Median:22694.55 stddev:81276.01 (358.1%) stddev-sans-first:81464.91 05:16:07 INFO - PID 13442 | Values: 562.8 568.0 570.3 572.3 575.8 21282.6 22212.7 22326.9 22335.2 22368.1 23282.2 25858.2 25919.0 25939.5 26077.6 6541.7 6616.7 6631.6 6648.8 6715.2 6537.8 6567.6 6571.7 6582.3 6601.3 5870.0 6446.8 6480.8 6498.2 6507.6 6426.0 6472.6 6476.5 6481.2 6492.3 5958.9 5966.0 5969.2 5972.5 5974.9 28000.3 28535.6 28824.9 29157.4 29489.0 1997.0 2056.9 2069.6 2072.1 2076.1 18871.9 19562.0 19564.9 19583.3 19601.1 2338.2 2369.5 2395.9 2415.9 2468.3 136018.0 140390.0 140638.3 141571.3 141951.0 13926.5 14484.3 14497.9 14773.3 15136.1 22605.4 22671.8 22676.5 22712.5 22745.4 9778.9 9889.9 10067.4 10090.0 10173.9 9196.8 9197.9 9218.1 9265.2 9464.3 8426.3 8660.2 8820.4 9063.7 9134.5 2623.2 2651.6 2689.8 2740.4 2835.7 915.7 930.9 947.8 958.4 963.8 17567.0 17627.6 17859.3 18517.4 18598.2 1003.1 1016.8 1020.1 1027.4 1029.8 10384.2 10386.7 10394.2 10524.9 10729.0 473797.0 478282.0 480699.0 482241.0 491030.0 112089.4 113847.4 114984.0 115044.0 117984.0 1093.2 1094.4 1113.1 1115.0 1117.6 16431.4 16495.4 16499.7 16513.3 16638.8 52064.0 55095.0 55808.0 55964.7 56171.4 66069.3 66926.3 67026.7 67085.0 71224.9 14265.7 14701.0 14739.9 14801.8 14820.2 22936.3 23031.0 23164.4 23305.2 23369.3 17214.1 17334.8 17344.7 17490.8 17614.4 16167.1 16629.9 16646.8 16993.0 17117.1 16377.3 16670.6 16966.9 17020.2 17049.2 13842.7 14445.1 14508.3 14531.3 14538.0 18060.4 18100.8 18140.3 18208.3 18241.3 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#3] mootools.html Cycles:180 Average:9103.44 Median:2629.10 stddev:6487.20 (246.7%) stddev-sans-first:6478.78 05:16:07 INFO - PID 13442 | Values: 1282.2 1315.6 1339.1 1341.7 1356.2 14411.4 14924.0 15008.7 15014.2 15024.3 14513.2 15495.0 15499.0 15502.3 15520.0 2649.2 2691.1 2718.6 2723.1 2724.3 2521.6 2533.4 2540.1 2591.0 2607.8 2621.9 2662.4 2669.9 2670.5 2679.6 2665.3 2669.8 2680.7 2681.9 2688.3 2601.9 2636.3 2650.0 2650.5 2691.9 14498.9 14578.9 14587.1 14613.6 14694.9 7657.0 7910.3 7925.1 7939.0 7942.5 5322.9 5401.9 5467.5 5511.6 5520.7 1869.9 1872.1 1891.3 1893.5 1911.9 25186.7 25437.7 25498.1 25518.2 25525.1 6472.6 6481.2 6526.5 6636.6 6650.4 16979.6 16980.3 17061.1 17111.7 17136.8 7477.9 7606.0 7624.3 7661.4 7672.3 6950.9 7020.3 7106.8 7135.4 7230.0 5012.5 5123.3 5135.1 5142.2 5233.7 1357.9 1363.3 1450.8 1487.6 1517.1 842.9 850.7 863.3 877.2 878.0 7227.6 7365.3 7478.7 7503.1 7607.6 922.6 944.6 945.3 948.4 951.7 4800.4 4930.7 4943.2 4946.2 4968.0 20230.2 20452.2 21199.0 21236.3 21272.4 20027.0 20505.3 20667.1 21260.7 21292.0 10274.2 10640.9 10644.7 10904.7 10945.8 8215.9 8447.7 8579.1 8586.0 8599.5 17376.5 17752.8 17960.3 17961.1 18097.2 16894.7 18041.5 18066.2 18427.4 18649.1 13553.3 13569.7 13695.5 13797.9 13809.1 13592.2 13832.9 13862.8 13867.7 13896.6 8560.3 10398.4 11284.0 11555.1 11738.0 11000.4 11132.9 11144.3 11231.4 11275.0 9225.5 9236.8 9238.6 9305.0 9345.4 6418.5 6502.0 6530.8 6565.9 6628.5 6766.2 6789.8 6957.5 6977.2 7040.2 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#4] prototype.html Cycles:180 Average:5497.53 Median:6144.26 stddev:1553.16 (25.3%) stddev-sans-first:1511.37 05:16:07 INFO - PID 13442 | Values: 491.1 499.2 516.0 517.7 527.3 6196.5 6217.9 6234.0 6265.9 6289.3 6084.1 6143.4 6145.1 6156.9 6250.2 5066.9 5067.2 5095.8 5113.3 5136.2 4697.4 4919.2 4925.5 5013.8 5107.1 4846.8 4895.0 4900.1 4901.1 4928.2 4826.0 4870.9 4892.2 4897.1 4947.5 4372.7 4374.6 4384.6 4386.0 4423.3 6054.8 6100.8 6114.5 6125.5 6184.9 5530.7 5550.7 5556.4 5604.7 5630.5 6399.5 6413.8 6452.6 6461.3 6524.6 4752.0 4759.3 4760.1 4763.3 4774.3 6507.4 6672.7 6681.6 6794.6 6919.1 4838.2 4900.6 4972.0 4973.4 4986.4 5004.8 5025.6 5069.0 5076.6 5079.5 5529.6 5616.5 5635.0 5649.7 5686.3 6487.3 6488.5 6569.3 6584.3 6621.9 1722.8 1762.4 1764.0 1773.5 1776.8 967.9 1222.4 1223.2 1236.2 1239.7 5805.9 5873.1 5895.0 5905.5 5908.4 6736.9 6740.6 6744.5 6820.9 6822.2 5778.9 5825.7 5851.9 5885.6 5904.3 3572.3 3599.1 3614.6 3615.2 3640.4 6679.5 6680.2 6691.7 6708.5 6717.1 6751.0 6849.0 6879.6 6922.8 6957.2 6583.3 6634.4 6654.5 6678.5 6696.6 6676.0 6741.2 6760.5 6761.0 6781.6 6023.4 6486.4 6524.4 6615.7 6655.7 6603.5 6652.3 6655.2 6687.5 6704.3 4894.5 4904.3 4917.9 4954.2 5019.1 6543.1 6603.8 6707.5 6769.3 6848.6 6411.9 6415.8 6451.2 6456.5 6506.7 6419.7 6427.4 6523.3 6558.1 6617.2 6344.0 6370.3 6372.9 6445.7 6455.3 6541.0 6550.1 6554.0 6555.8 6629.8 6235.7 6343.5 6362.2 6386.2 6409.5 05:16:07 INFO - PID 13442 | 05:16:07 INFO - PID 13442 | [#5] yui.html Cycles:180 Average:23011.82 Median:20553.73 stddev:31714.08 (154.3%) stddev-sans-first:31759.52 05:16:07 INFO - PID 13442 | Values: 884.2 892.9 896.7 915.4 916.2 18239.0 19420.0 19479.2 19495.5 19497.3 17349.2 17425.0 18144.2 18228.4 18396.4 947.6 960.9 961.3 961.7 967.2 950.0 952.9 959.9 966.1 967.4 905.6 980.1 985.0 989.5 995.8 983.6 988.3 991.6 992.7 993.2 715.8 722.4 724.2 724.5 727.5 17641.1 17760.0 17878.9 17913.5 19035.6 19928.2 20060.8 20264.9 20531.9 20555.3 16533.1 16768.2 16952.8 16968.3 16986.2 3658.9 3660.1 3671.2 3671.5 3672.2 117907.0 123378.4 123946.0 124326.4 125622.0 16304.8 16607.8 16616.3 16622.7 16628.8 28292.6 29115.9 29289.4 29297.3 29362.9 8187.5 8754.5 8773.0 8799.2 8801.5 4163.2 4208.7 4252.3 4258.0 4300.7 4992.7 5042.0 5095.7 5129.7 5139.8 1075.4 1089.2 1096.3 1103.7 1108.9 660.8 680.1 684.4 686.0 689.5 10480.0 10658.6 10721.5 10905.3 10972.5 650.4 660.0 674.8 677.3 680.2 4794.9 5016.0 5979.5 6213.3 6336.6 108319.0 109106.0 111997.0 112440.4 112894.0 98491.5 98770.0 100366.0 100857.5 102481.0 87677.0 88078.0 88789.6 89923.6 91280.5 12044.9 12205.4 12207.8 12275.7 12311.1 39897.8 40122.6 40593.0 41618.0 42295.6 50751.0 51285.2 52274.2 53098.0 53283.2 13787.2 17680.6 18062.5 18177.5 18201.8 16919.4 17224.4 18674.3 20552.2 20962.4 18719.7 18766.7 18968.9 19039.0 19068.0 17477.9 17481.5 17490.1 17504.7 17705.9 16653.8 16796.3 16969.4 16972.6 17260.8 12168.5 12386.8 12425.5 12459.9 12572.7 13933.0 13997.7 14001.2 14153.2 14358.6 05:16:07 INFO - PID 13442 | -------- Summary: end -------- 05:16:07 INFO - PID 13442 | 05:16:08 INFO - TEST-INFO | 13442: exit 0 05:16:08 INFO - TEST-OK | dromaeo_css | took 1114131ms 05:16:08 INFO - TEST-START | kraken 05:16:08 INFO - Initialising browser for kraken test... 05:16:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55612/getInfo.html -profile /tmp/tmpynaefn/profile 05:16:08 INFO - TEST-INFO | started process 13865 (/builds/slave/test/build/application/firefox/firefox http://localhost:55612/getInfo.html) 05:16:14 INFO - TEST-INFO | 13865: exit 0 05:16:14 INFO - Browser initialized. 05:16:14 INFO - Running cycle 1/1 for kraken test... 05:16:14 INFO - Using env: {'DISPLAY': ':0', 05:16:14 INFO - 'HOME': '/home/cltbld', 05:16:14 INFO - 'JSGC_DISABLE_POISONING': '1', 05:16:14 INFO - 'LANG': 'en_US.UTF-8', 05:16:14 INFO - 'LANGUAGE': 'en_US:en', 05:16:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:16:14 INFO - 'LOGNAME': 'cltbld', 05:16:14 INFO - 'MAIL': '/var/mail/cltbld', 05:16:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:14 INFO - 'MOZ_ACCELERATED': '1', 05:16:14 INFO - 'MOZ_CRASHREPORTER': '1', 05:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:16:14 INFO - 'MOZ_NO_REMOTE': '1', 05:16:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:14 INFO - 'MOZ_WEBRENDER': '1', 05:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:14 INFO - 'NO_EM_RESTART': '1', 05:16:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:14 INFO - 'PWD': '/builds/slave/test', 05:16:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:14 INFO - 'RUST_BACKTRACE': 'full', 05:16:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:14 INFO - 'SHELL': '/bin/bash', 05:16:14 INFO - 'SHLVL': '1', 05:16:14 INFO - 'TERM': 'linux', 05:16:14 INFO - 'TMOUT': '86400', 05:16:14 INFO - 'USER': 'cltbld', 05:16:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097', 05:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:14 INFO - '_': '/tools/buildbot/bin/python'} 05:16:14 INFO - TEST-INFO | started process 14048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpynaefn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:15 INFO - PID 14048 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:16:15 INFO - PID 14048 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:16:15 INFO - PID 14048 | 05:16:15 INFO - PID 14048 | (/builds/slave/test/build/application/firefox/firefox:14107): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:15 INFO - PID 14048 | 05:16:16 INFO - PID 14048 | 05:16:16 INFO - PID 14048 | (/builds/slave/test/build/application/firefox/firefox:14165): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:16 INFO - PID 14048 | 05:16:16 INFO - PID 14048 | __metrics Screen width/height:1600/1200 05:16:16 INFO - PID 14048 | colorDepth:24 05:16:16 INFO - PID 14048 | Browser inner width/height: 1024/768 05:16:16 INFO - PID 14048 | __metrics 05:16:25 INFO - PID 14048 | RSS: Main: 201125888 05:16:25 INFO - PID 14048 | 05:16:28 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55612/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:29 INFO - PID 14048 | RSS: Main: 206622720 05:16:29 INFO - PID 14048 | 05:16:29 INFO - PID 14048 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:16:32 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55612/tests/kraken/driver.html?testName=audio-dft) 05:16:32 INFO - PID 14048 | RSS: Main: 209686528 05:16:32 INFO - PID 14048 | 05:16:35 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55612/tests/kraken/driver.html?testName=audio-fft) 05:16:36 INFO - PID 14048 | RSS: Main: 202399744 05:16:36 INFO - PID 14048 | 05:16:38 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55612/tests/kraken/driver.html?testName=audio-oscillator) 05:16:39 INFO - PID 14048 | RSS: Main: 204427264 05:16:39 INFO - PID 14048 | 05:16:41 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:42 INFO - PID 14048 | RSS: Main: 204419072 05:16:42 INFO - PID 14048 | 05:16:45 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55612/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:45 INFO - PID 14048 | RSS: Main: 205963264 05:16:45 INFO - PID 14048 | 05:16:49 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55612/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:50 INFO - PID 14048 | RSS: Main: 205148160 05:16:50 INFO - PID 14048 | 05:16:53 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55612/tests/kraken/driver.html?testName=json-parse-financial) 05:16:53 INFO - PID 14048 | RSS: Main: 206336000 05:16:53 INFO - PID 14048 | 05:16:55 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:55 INFO - PID 14048 | RSS: Main: 205455360 05:16:55 INFO - PID 14048 | 05:16:57 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:58 INFO - PID 14048 | RSS: Main: 205426688 05:16:58 INFO - PID 14048 | 05:17:00 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:01 INFO - PID 14048 | RSS: Main: 205959168 05:17:01 INFO - PID 14048 | 05:17:03 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:04 INFO - PID 14048 | RSS: Main: 205373440 05:17:04 INFO - PID 14048 | 05:17:07 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:08 INFO - PID 14048 | RSS: Main: 206139392 05:17:08 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | Cycle 1(1): loaded http://localhost:55612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55612/tests/kraken/driver.html?testName=ai-astar) 05:17:10 INFO - PID 14048 | RSS: Main: 208007168 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | __start_tp_report 05:17:10 INFO - PID 14048 | _x_x_mozilla_page_load 05:17:10 INFO - PID 14048 | _x_x_mozilla_page_load_details 05:17:10 INFO - PID 14048 | |i|pagename|runs| 05:17:10 INFO - PID 14048 | |0;ai-astar;105;110;107;115;112;112;111;99;109;117 05:17:10 INFO - PID 14048 | |1;audio-beat-detection;146;127;143;188;117;154;158;123;178;126 05:17:10 INFO - PID 14048 | |2;audio-dft;166;166;163;165;173;177;169;165;162;171 05:17:10 INFO - PID 14048 | |3;audio-fft;78;75;74;167;76;81;73;76;158;75 05:17:10 INFO - PID 14048 | |4;audio-oscillator;85;80;140;86;86;79;138;80;80;140 05:17:10 INFO - PID 14048 | |5;imaging-gaussian-blur;114;115;114;119;122;115;114;122;115;115 05:17:10 INFO - PID 14048 | |6;imaging-darkroom;152;160;149;157;148;158;150;152;157;155 05:17:10 INFO - PID 14048 | |7;imaging-desaturate;99;95;96;94;98;94;94;97;94;100 05:17:10 INFO - PID 14048 | |8;json-parse-financial;52;53;51;61;55;52;57;52;52;52 05:17:10 INFO - PID 14048 | |9;json-stringify-tinderbox;56;55;55;73;56;61;56;62;66;58 05:17:10 INFO - PID 14048 | |10;stanford-crypto-aes;75;76;82;83;76;80;81;77;76;81 05:17:10 INFO - PID 14048 | |11;stanford-crypto-ccm;120;123;123;132;121;134;132;127;122;160 05:17:10 INFO - PID 14048 | |12;stanford-crypto-pbkdf2;182;183;173;171;174;175;190;176;173;176 05:17:10 INFO - PID 14048 | |13;stanford-crypto-sha256-iterative;72;75;66;66;70;66;64;75;67;64 05:17:10 INFO - PID 14048 | __end_tp_report 05:17:10 INFO - PID 14048 | __start_cc_report 05:17:10 INFO - PID 14048 | _x_x_mozilla_cycle_collect,932 05:17:10 INFO - PID 14048 | __end_cc_report 05:17:10 INFO - PID 14048 | __startTimestamp1503663430421__endTimestamp 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | ------- Summary: start ------- 05:17:10 INFO - PID 14048 | Number of tests: 14 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:5.14 (4.6%) stddev-sans-first:5.17 05:17:10 INFO - PID 14048 | Values: 105.0 110.0 107.0 115.0 112.0 112.0 111.0 99.0 109.0 117.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:150.00 stddev:23.89 (15.9%) stddev-sans-first:25.34 05:17:10 INFO - PID 14048 | Values: 146.0 127.0 143.0 188.0 117.0 154.0 158.0 123.0 178.0 126.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#2] audio-dft Cycles:10 Average:167.70 Median:167.50 stddev:4.74 (2.8%) stddev-sans-first:4.99 05:17:10 INFO - PID 14048 | Values: 166.0 166.0 163.0 165.0 173.0 177.0 169.0 165.0 162.0 171.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.50 stddev:36.60 (48.5%) stddev-sans-first:38.40 05:17:10 INFO - PID 14048 | Values: 78.0 75.0 74.0 167.0 76.0 81.0 73.0 76.0 158.0 75.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:80.00 stddev:27.69 (34.6%) stddev-sans-first:28.87 05:17:10 INFO - PID 14048 | Values: 85.0 80.0 140.0 86.0 86.0 79.0 138.0 80.0 80.0 140.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:115.00 stddev:3.24 (2.8%) stddev-sans-first:3.31 05:17:10 INFO - PID 14048 | Values: 114.0 115.0 114.0 119.0 122.0 115.0 114.0 122.0 115.0 115.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#6] imaging-darkroom Cycles:10 Average:153.80 Median:156.00 stddev:4.16 (2.7%) stddev-sans-first:4.36 05:17:10 INFO - PID 14048 | Values: 152.0 160.0 149.0 157.0 148.0 158.0 150.0 152.0 157.0 155.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:2.28 (2.4%) stddev-sans-first:2.17 05:17:10 INFO - PID 14048 | Values: 99.0 95.0 96.0 94.0 98.0 94.0 94.0 97.0 94.0 100.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:52.50 stddev:3.13 (6.0%) stddev-sans-first:3.26 05:17:10 INFO - PID 14048 | Values: 52.0 53.0 51.0 61.0 55.0 52.0 57.0 52.0 52.0 52.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:5.88 (9.9%) stddev-sans-first:6.08 05:17:10 INFO - PID 14048 | Values: 56.0 55.0 55.0 73.0 56.0 61.0 56.0 62.0 66.0 58.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:80.50 stddev:2.98 (3.7%) stddev-sans-first:2.85 05:17:10 INFO - PID 14048 | Values: 75.0 76.0 82.0 83.0 76.0 80.0 81.0 77.0 76.0 81.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:129.50 stddev:11.89 (9.2%) stddev-sans-first:12.12 05:17:10 INFO - PID 14048 | Values: 120.0 123.0 123.0 132.0 121.0 134.0 132.0 127.0 122.0 160.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:176.00 stddev:5.89 (3.3%) stddev-sans-first:6.00 05:17:10 INFO - PID 14048 | Values: 182.0 183.0 173.0 171.0 174.0 175.0 190.0 176.0 173.0 176.0 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:4.22 (6.2%) stddev-sans-first:4.28 05:17:10 INFO - PID 14048 | Values: 72.0 75.0 66.0 66.0 70.0 66.0 64.0 75.0 67.0 64.0 05:17:10 INFO - PID 14048 | -------- Summary: end -------- 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | 05:17:10 INFO - PID 14048 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:17:10 INFO - PID 14048 | 05:17:11 INFO - PID 14048 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:17:11 INFO - TEST-INFO | 14048: exit 0 05:17:11 INFO - TEST-OK | kraken | took 63346ms 05:17:11 INFO - SUITE-END | took 1177s 05:17:12 INFO - Completed test suite (00:19:37) 05:17:12 INFO - javascript benchmark 05:17:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8326.830364663443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.6189338226113, 3319.41910165721, 3333.399988002159, 3333.833308334584, 3340.4488259437194, 6150.200473938393, 6219.7512099516025, 6243.157173781538, 6269.937300626998, 6305.8108256752375, 6123.050927106306, 6233.532485063615, 6260.530460215491, 6261.624302541851, 6264.780732674358, 5678.205051292823, 5692.203091567194, 5692.800751973682, 5693.544516438696, 5716.28546431696, 5763.827085187451, 5789.334226563936, 5803.564732645069, 5814.156947242668, 5846.824595262149, 5706.686132262724, 5746.655200687951, 5767.538596912237, 5802.738876750535, 5832.6792026438525, 94.86303517213896, 5604.831855044315, 5657.038303488417, 5838.241028666267, 5846.9707651461895, 5609.943900560983, 5668.149777533362, 5685.346185188715, 5721.141828725683, 5728.570357223225, 6139.355367686373, 6230.190075290228, 6252.468540174091, 6289.7169627366875, 6338.524610654219, 6635.336466353374, 6674.365935236145, 6690.83272918181, 6798.116244888182, 6803.285655006202, 6721.1598550181225, 6723.697433615499, 6732.798016059526, 6831.726730930757, 6832.111825462708, 5983.611065280743, 6197.380261973857, 6197.504199664016, 6282.403171698681, 6345.746170153235, 6765.086713293741, 6787.830304242335, 6822.317768223138, 6853.0, 6864.656767161622, 6479.060536222221, 6506.739730410731, 6507.056476810836, 6513.73945042193, 6563.868722625521, 6537.411632952962, 6562.212534495796, 6618.86762264752, 6642.036904648799, 6648.16897887764, 6672.366125218194, 6686.933130668728, 6698.799036028927, 6756.966215168893, 6770.187577490733, 6665.666716664147, 6679.131712877295, 6730.629815360105, 6751.25736169021, 6753.662316884136, 5219.791208351699, 5282.656627319212, 5292.629515933848, 5352.143657014859, 5362.785488580491, 4686.5782079613, 4716.976415117971, 4722.268048452495, 4725.905481890343, 4740.19416699162, 5813.447722466359, 5868.94131058684, 5912.645241285537, 5942.138389933435, 5965.582409231312, 6709.36261055199, 6751.4261287790105, 6780.966095169492, 6836.248012718597, 6839.760608378683, 5664.150377443334, 5790.189373487715, 5804.187413762077, 5817.156512305776, 5908.793192238251, 5693.772249110072, 5698.686572238484, 5709.942900571024, 5710.685912274865, 5712.857178570569, 6436.645984470805, 6444.258910225384, 6456.0961465394885, 6466.870662586722, 6663.13379260693, 6666.100076489805, 6681.164854393103, 6726.529142959946, 6741.696623652046, 6779.661016949231, 6262.5929314594405, 6526.184226971629, 6678.165229346332, 6683.365080317362, 6704.296048914794, 6623.801285961429, 6656.83357916056, 6657.201135863534, 6672.299408562031, 6753.831154220988, 6452.935470645233, 6575.473962083118, 6579.243387010555, 6587.4071333580205, 6772.695228714621, 6461.483081353386, 6531.2489063756375, 6544.934550654432, 6593.472522198309, 6596.934030659824, 6580.76967306142, 6586.407223349922, 6601.900971485527, 6606.306337834651, 6609.537332386687, 6284.811455656338, 6337.683115844097, 6431.742730290736, 6455.515836312202, 6550.0, 6442.323556026738, 6457.61254324742, 6499.285078641251, 6504.9674751625935, 6521.804345869631, 6307.400796924285, 6312.495000400048, 6312.621242725451, 6342.936570634234, 6344.175257216532], "value": 6073.717664350523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.4560716284274, 826.404988408346, 850.5704619167324, 852.122314016563, 1113.5768408004958, 28541.714582854165, 29171.0, 29190.708092919092, 37809.24381512368, 39208.0, 38391.61608383915, 38864.22271554567, 38866.0, 38890.80554597223, 38891.611083889155, 5632.690202038886, 7472.17806041335, 7605.239476052406, 7608.505447145945, 7609.619519024054, 5737.655740655553, 7429.777106686808, 7563.394928405714, 7590.506617069873, 7620.390368770512, 7580.469367144302, 7596.696132154707, 7612.7335543255995, 7630.2369763023535, 7632.465727399084, 7532.510386824839, 7593.0, 7600.543967361976, 7610.6194690265265, 7627.733029343946, 7322.377597904185, 7340.155882073576, 7388.556686598821, 7389.334959853585, 7408.666610002563, 34934.47598286028, 35006.47490287648, 35024.29951400957, 35118.82440587806, 35118.82440587806, 3375.7468189885612, 3403.914902127442, 3416.299658569987, 3417.4361230396953, 3419.5212670226188, 29342.266443338875, 29387.0, 29448.263793405124, 29461.26346841346, 29476.410471790445, 4854.514548545152, 4995.550400463976, 5023.372078490189, 5048.192289233742, 5143.614228932807, 181604.0, 182147.0, 182302.0, 182637.0, 183588.08205959018, 44663.77668111639, 44713.776431117636, 45010.54989450129, 45064.0, 45181.09637807225, 46290.5370946293, 46791.766041169576, 49190.75404623026, 50262.0, 50350.0, 15461.304241309168, 15586.376544938303, 15612.3755049799, 15620.609484762972, 15632.2183890805, 12721.872781272254, 12760.234385936874, 12763.106582539132, 12764.297963611905, 12771.0, 13823.654408639663, 14043.50847720325, 14101.576952691436, 14120.71758564823, 14159.504417345344, 5485.917711234335, 5505.9724701376235, 5648.604597678123, 5695.572832037614, 5718.942810571924, 965.7875267441152, 968.3463662028103, 974.8342781727123, 992.2161492421051, 997.3915911294105, 20827.0, 20849.58300833975, 21169.78830211678, 21316.147354105662, 21680.674789878165, 1054.2093429927554, 1069.6470164845582, 1077.9892201078046, 1078.229066217658, 1093.5133865429807, 11324.716882078013, 11492.138089643311, 11508.136889733303, 11563.6530904073, 11611.303321800719, 228564.0, 228669.0, 229926.0, 230265.0, 230270.0, 47834.521654783704, 47969.0, 48263.27605085926, 48416.27375589369, 48493.757531212825, 1365.6244532753572, 1407.0713329202881, 1413.5123382433044, 1417.3905220755175, 1421.4953691439391, 20027.19891204394, 20033.79966200319, 20259.29092481756, 20371.79628203699, 20458.38624841257, 34035.0, 34147.14632134217, 34287.65712342845, 34289.48565771466, 34339.31321373609, 191822.0, 194528.0, 194599.0, 194915.0, 194991.0, 27870.16389508318, 28435.43129137447, 31321.216969575944, 31459.52810707887, 31586.210344741565, 39783.40324895071, 40020.1995960085, 40198.79900600478, 40221.396679049256, 40585.1882962345, 28886.0, 29103.41793164167, 29331.266718332212, 29467.85266073656, 29622.851885740434, 29144.27139321534, 29520.557191642572, 29704.10887673373, 29749.392889844927, 30233.546496803006, 32262.516062259554, 32335.514967275038, 32470.837645811618, 32527.512087318235, 32877.50683739698, 28973.420531589672, 29147.562786557795, 29215.0, 29313.56029659514, 29522.704772952853, 22291.665625015314, 22343.9429550254, 22362.552748945254, 22454.663180051986, 22634.0], "value": 16168.714173549999, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.7523889488627, 567.9602427830051, 570.3156212544947, 572.2703552969963, 575.8157389635317, 21282.57434851304, 22212.666809997863, 22326.88836555819, 22335.218267360626, 22368.10527578895, 23282.18512352068, 25858.224253272387, 25919.0, 25939.481210375827, 26077.60883586748, 6541.705623246965, 6616.702248398834, 6631.568948018387, 6648.7672931447405, 6715.160604924385, 6537.803865884031, 6567.638779867106, 6571.67141642916, 6582.308857569958, 6601.2738598754095, 5869.9706501467435, 6446.774362897299, 6480.837979050514, 6498.220213574377, 6507.6420796856155, 6426.036094585803, 6472.644004579746, 6476.4818814494965, 6481.222253329607, 6492.3183065777885, 5958.940410595882, 5966.045432730785, 5969.194158788551, 5972.462478376923, 5974.894644490783, 28000.299992500146, 28535.571966420313, 28824.85587572049, 29157.41685166306, 29489.0, 1997.0414201183514, 2056.907439165226, 2069.5757369739167, 2072.067569593689, 2076.1487790006026, 18871.905640471847, 19562.0, 19564.902175489173, 19583.314583989635, 19601.1179496923, 2338.181636427254, 2369.5497855407416, 2395.9098610132346, 2415.855048697084, 2468.2841975826987, 136018.0, 140390.0, 140638.29680851632, 141571.29214353964, 141951.0, 13926.512572060132, 14484.275786210648, 14497.927510362591, 14773.335199915815, 15136.091834489745, 22605.43486412853, 22671.773282267295, 22676.546469070527, 22712.545749084926, 22745.431364216027, 9778.853317200248, 9889.901100988898, 10067.446290454096, 10090.0, 10173.898261017295, 9196.816063678689, 9197.908020919838, 9218.124278193562, 9265.212456941235, 9464.290178236659, 8426.283765879969, 8660.220580147818, 8820.382573219813, 9063.728088157366, 9134.543272836465, 2623.22614828626, 2651.6022596610665, 2689.784817214618, 2740.397112635217, 2835.6597208335133, 915.7435917942987, 930.9115634014893, 947.7583216279804, 958.4393130018877, 963.7735132243918, 17567.0, 17627.55931101733, 17859.28562857471, 18517.44447666572, 18598.16308266131, 1003.0521157506232, 1016.761061150629, 1020.1430798129607, 1027.3784360461962, 1029.7888932768765, 10384.221183411275, 10386.688399348031, 10394.16846652266, 10524.947505249567, 10729.0, 473797.0, 478282.0, 480699.0, 482241.0, 491030.0, 112089.43955280172, 113847.43076284566, 114984.0, 115044.0, 117984.0, 1093.2238110941162, 1094.392612100276, 1113.059464752283, 1115.0466351269547, 1117.580907159815, 16431.424900128437, 16495.422660206834, 16499.67000659956, 16513.256903439134, 16638.750418743486, 52064.0, 55095.0, 55808.0, 55964.720176398856, 56171.43828561662, 66069.33930660631, 66926.33073669396, 67026.66486667536, 67085.0, 71224.9316260267, 14265.71468570602, 14701.0, 14739.852601474277, 14801.777973330194, 14820.184889831164, 22936.311910642708, 23031.0, 23164.420889477897, 23305.18431854877, 23369.298921032398, 17214.139293035547, 17334.82665173332, 17344.653106938043, 17490.82509174943, 17614.383496577557, 16167.110808905623, 16629.91685041567, 16646.833531665012, 16992.98042117477, 17117.14414279256, 16377.263023163749, 16670.58323541921, 16966.915165424092, 17020.234089465757, 17049.232784524975, 13842.65393365174, 14445.06107103035, 14508.34712437964, 14531.273436328353, 14538.0, 18060.367887123888, 18100.818991809912, 18140.274389024293, 18208.271669133086, 18241.270349186416], "value": 11703.645911942409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.2498838179665, 1315.6184706435133, 1339.1028011232477, 1341.7115320206153, 1356.2133962301866, 14411.423543058278, 14924.0, 15008.699826003472, 15014.24928753562, 15024.323905424255, 14513.20177390243, 15495.0, 15499.0, 15502.30239639216, 15519.991200571954, 2649.244965184923, 2691.1119330620945, 2718.592211168321, 2723.128598848369, 2724.346156922334, 2521.6343630173615, 2533.4173140177772, 2540.0982651158756, 2591.041314713549, 2607.8304910180873, 2621.908233211838, 2662.4142688608476, 2669.919902402931, 2670.505956398063, 2679.6382488364115, 2665.3070201747587, 2669.7997650176317, 2680.6783186017706, 2681.9061332853453, 2688.3144798076364, 2601.9219423417326, 2636.2882021853993, 2649.973500264992, 2650.483155784623, 2691.9461610767676, 14498.855011449856, 14578.854211457856, 14587.051841630366, 14613.561593152222, 14694.926525367411, 7657.0, 7910.2880740733035, 7925.088614809255, 7939.0, 7942.483738556975, 5322.893542129135, 5401.891962160774, 5467.45325467454, 5511.559075274008, 5520.696361700145, 1869.9158537865828, 1872.140201170328, 1891.297831951241, 1893.5360836594984, 1911.923523059076, 25186.748132518624, 25437.745622543724, 25498.107566235092, 25518.23445296644, 25525.10662126835, 6472.644004579794, 6481.222253329631, 6526.543141980016, 6636.568623039487, 6650.401463868178, 16979.575510612332, 16980.32078716862, 17061.061641609584, 17111.657766844593, 17136.828631713524, 7477.85044299111, 7606.04924384452, 7624.313811756969, 7661.387089032864, 7672.271134242238, 6950.860982780316, 7020.297970203041, 7106.786796396116, 7135.393491553276, 7230.0, 5012.548870601663, 5123.3339665843205, 5135.075686376488, 5142.177251639794, 5233.71214583194, 1357.9456821727217, 1363.2638375277238, 1450.7678771396527, 1487.5537338798317, 1517.1124891938118, 842.8904242448442, 850.6980022092192, 863.2834747159842, 877.2105105405186, 877.9736607901773, 7227.602481863548, 7365.263473652699, 7478.70085196586, 7503.09962804467, 7607.581583012877, 922.6125027488471, 944.6457578408097, 945.3099237556622, 948.4025064209504, 951.6574033347989, 4800.399950006249, 4930.679505832181, 4943.209086546135, 4946.208606622923, 4968.0, 20230.19079236814, 20452.181912723623, 21199.0, 21236.25673101434, 21272.36182914515, 20027.0, 20505.2823151189, 20667.06998185085, 21260.681089783666, 21292.0, 10274.178065754722, 10640.946795266129, 10644.680659580225, 10904.672859814218, 10945.781084378426, 8215.917840821754, 8447.746567602982, 8579.056303806452, 8586.0, 8599.484030958163, 17376.478705638852, 17752.822471775118, 17960.281588736303, 17961.101944902963, 18097.185626647097, 16894.66210675804, 18041.548961276072, 18066.187021584323, 18427.447176584723, 18649.067546622344, 13553.322333883463, 13569.710877466625, 13695.520656776966, 13797.931010344884, 13809.102408343426, 13592.184468931895, 13832.930835346162, 13862.792058119338, 13867.722645547234, 13896.58310250694, 8560.315174785877, 10398.428086455015, 11284.0, 11555.133364997491, 11738.0, 11000.449977500934, 11132.88867111351, 11144.275622084539, 11231.438428078727, 11275.0, 9225.538723063686, 9236.769080773034, 9238.584263708015, 9305.0, 9345.439273643604, 6418.486521078209, 6502.0246962955935, 6530.8367290818105, 6565.916623757218, 6628.53600247978, 6766.221884483348, 6789.796306110825, 6957.547759395623, 6977.197622273504, 7040.190378106583], "value": 6502.27368662724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.11599121581156, 499.1962939667133, 515.9871003224919, 517.7256054291225, 527.2776296473832, 6196.473299769519, 6217.906731399022, 6233.9816447759595, 6265.9060114098265, 6289.339619339972, 6084.087386891957, 6143.416375444337, 6145.108959200913, 6156.907646385296, 6250.156228909096, 5066.949330506684, 5067.214581739827, 5095.796168153288, 5113.309703190059, 5136.152534831767, 4697.389339385875, 4919.2129259318335, 4925.497723194442, 5013.771625951628, 5107.131787596099, 4846.757662116897, 4895.0, 4900.117978763821, 4901.142300097486, 4928.186849169882, 4825.951740482586, 4870.878228044292, 4892.168331383637, 4897.114610874821, 4947.480514545975, 4372.737635741865, 4374.6062854342945, 4384.596928982727, 4385.978070109661, 4423.314386270134, 6054.757809687607, 6100.755969761204, 6114.541409394314, 6125.499252683121, 6184.9176394130845, 5530.72793257553, 5550.72246387679, 5556.444355564452, 5604.70207215044, 5630.493255607015, 6399.488040956712, 6413.8396540086405, 6452.580582262138, 6461.289258181643, 6524.641144737037, 4751.952480475185, 4759.309900064472, 4760.071786001731, 4763.285507173917, 4774.259989701602, 6507.414332710032, 6672.7330906764155, 6681.632510211985, 6794.626295553742, 6919.135108111486, 4838.153323168502, 4900.57883213864, 4972.0, 4973.353464049723, 4986.426560945538, 5004.824831130893, 5025.572826309732, 5068.983954547039, 5076.568491678248, 5079.517445842639, 5529.585281103853, 5616.466435688603, 5634.971825140848, 5649.717514124277, 5686.346070201897, 6487.318831522716, 6488.545801793924, 6569.310222426672, 6584.275729669733, 6621.9337806621315, 1722.8191039940625, 1762.4007837335369, 1763.982360176382, 1773.4590949760188, 1776.7601373814628, 967.8741763570831, 1222.413241644016, 1223.2110288863812, 1236.2458900070949, 1239.7458521003173, 5805.941940580625, 5873.119032145212, 5894.970525147432, 5905.4685078343155, 5908.438698323653, 6736.8989465158065, 6740.629265390353, 6744.527883048139, 6820.897686534706, 6822.181338239443, 5778.855528611818, 5825.7378417971295, 5851.882962340729, 5885.61743486672, 5904.291485021825, 3572.321258960841, 3599.1182160370354, 3614.566252049718, 3615.168511242429, 3640.4357324614725, 6679.532432729662, 6680.164979377578, 6691.698873550702, 6708.463322934153, 6717.1267735194115, 6751.0, 6848.9795510324575, 6879.58722476653, 6922.826929326807, 6957.234704182536, 6583.308752581006, 6634.402903738686, 6654.534182607268, 6678.5307232408795, 6696.63168525726, 6676.0, 6741.157355330583, 6760.492963027891, 6760.966195168992, 6781.6097699970405, 6023.397660233942, 6486.4486518646445, 6524.380183882524, 6615.702293396713, 6655.73377064912, 6603.471722262111, 6652.301508341748, 6655.23464801554, 6687.531872769054, 6704.329567043256, 4894.51054894522, 4904.308013735255, 4917.852464426073, 4954.232094025432, 5019.121653710513, 6543.149390579194, 6603.80188594343, 6707.5304728668525, 6769.289224631343, 6848.623325717133, 6411.903821442776, 6415.839604009937, 6451.1936007999, 6456.54804163704, 6506.739730410731, 6419.743210271724, 6427.389398007182, 6523.3150519194805, 6558.081868538504, 6617.172853393326, 6343.986606362126, 6370.26741924666, 6372.872542549216, 6445.70994305248, 6455.289918108911, 6541.0, 6550.050242714875, 6554.016897465418, 6555.836104097436, 6629.801105966829, 6235.657038862724, 6343.460805831556, 6362.204724409449, 6386.16979792624, 6409.487241020801], "value": 5038.211327890964, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.226301985762, 892.8571428571428, 896.6816780043084, 915.3958387464274, 916.1708653668428, 18239.0, 19420.0, 19479.22083116677, 19495.512612184702, 19497.3175938842, 17349.219285132167, 17425.0, 18144.18351174197, 18228.362007329746, 18396.35612753554, 947.5688561704425, 960.8558716192592, 961.3414810854587, 961.6586111930269, 967.1585720423207, 950.0, 952.8951815300311, 959.8656188133667, 966.077396086739, 967.351874244258, 905.5608030105426, 980.0983095552074, 984.9704508864745, 989.5448093876826, 995.8257304971637, 983.5623147699276, 988.3229987458614, 991.5736233419626, 992.6972273456593, 993.1905497019978, 715.8282012317059, 722.4076257468878, 724.2106104346235, 724.4602770935634, 727.4871215792854, 17641.117944102873, 17760.023198724066, 17878.91060544702, 17913.462596122135, 19035.61928761417, 19928.202871885107, 20060.784196108973, 20264.898675506676, 20531.89734051335, 20555.280565180146, 16533.090680012596, 16768.161591920478, 16952.83047169537, 16968.3212671493, 16986.15069246545, 3658.9451158232646, 3660.1032746976894, 3671.173985853162, 3671.504346913159, 3672.2471893262086, 117907.0, 123378.38310808389, 123946.0, 124326.37836810759, 125622.0, 16304.836951630568, 16607.83392166063, 16616.335346586002, 16622.66754664924, 16628.750568741478, 28292.575611365846, 29115.85442072776, 29289.414211716074, 29297.267568310537, 29362.853185734362, 8187.467814592152, 8754.518501482353, 8773.034966153718, 8799.208071273617, 8801.47191168532, 4163.208990291835, 4208.684348673862, 4252.277112890816, 4257.978710106491, 4300.677449191323, 4992.72540010303, 5042.0, 5095.668781529189, 5129.743512824344, 5139.820106296262, 1075.4300220882944, 1089.1831126655009, 1096.2819353323587, 1103.6688993301977, 1108.9223754337281, 660.7687309441657, 680.1464162476061, 684.4216636941776, 685.9931400686029, 689.5380095336137, 10480.0, 10658.626948056935, 10721.517531711092, 10905.309677000077, 10972.506237219344, 650.4373716735084, 659.9769008084694, 674.7908148473989, 677.2888467109515, 680.2041611314773, 4794.879603788371, 5016.046951079356, 5979.4917432018765, 6213.285472170668, 6336.58812177207, 108319.0, 109106.0, 111997.0, 112440.43779781212, 112894.0, 98491.50754246327, 98770.0, 100366.0, 100857.49571252243, 102480.97519024863, 87677.0, 88078.0, 88789.55605222062, 89923.55038224637, 91280.54359728291, 12044.939775301067, 12205.389730513261, 12207.816882746589, 12275.69310767238, 12311.13822032485, 39897.80051099726, 40122.59877401189, 40593.0, 41618.0, 42295.5770442304, 50751.0, 51285.23072153846, 52274.21588676249, 53098.0, 53283.20075198953, 13787.172769633855, 17680.646387072444, 18062.458126256235, 18177.545561361072, 18201.81798182001, 16919.407820726214, 17224.397146099825, 18674.25302987865, 20552.17791288332, 20962.371128866158, 18719.719204211677, 18766.718499222796, 18968.905155474135, 19039.0, 19068.0, 17477.912610436866, 17481.47555573335, 17490.12549372501, 17504.73742893883, 17705.911470442566, 16653.834231603672, 16796.328146874475, 16969.406070787463, 16972.575685607466, 17260.82739172592, 12168.478940132483, 12386.75226495447, 12425.502979880703, 12459.875401245872, 12572.685682858002, 13933.0, 13997.720045599235, 14001.22993235382, 14153.221572813594, 14358.641033974234], "value": 8852.396137612042, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 107.0, 115.0, 112.0, 112.0, 111.0, 99.0, 109.0, 117.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 127.0, 143.0, 188.0, 117.0, 154.0, 158.0, 123.0, 178.0, 126.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 163.0, 165.0, 173.0, 177.0, 169.0, 165.0, 162.0, 171.0], "value": 167.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 167.0, 76.0, 81.0, 73.0, 76.0, 158.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 140.0, 86.0, 86.0, 79.0, 138.0, 80.0, 80.0, 140.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 119.0, 122.0, 115.0, 114.0, 122.0, 115.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 160.0, 149.0, 157.0, 148.0, 158.0, 150.0, 152.0, 157.0, 155.0], "value": 153.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 96.0, 94.0, 98.0, 94.0, 94.0, 97.0, 94.0, 100.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 61.0, 55.0, 52.0, 57.0, 52.0, 52.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 73.0, 56.0, 61.0, 56.0, 62.0, 66.0, 58.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 82.0, 83.0, 76.0, 80.0, 81.0, 77.0, 76.0, 81.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 123.0, 132.0, 121.0, 134.0, 132.0, 127.0, 122.0, 160.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 173.0, 171.0, 174.0, 175.0, 190.0, 176.0, 173.0, 176.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 66.0, 66.0, 70.0, 66.0, 64.0, 75.0, 67.0, 64.0], "value": 68.5, "unit": "score"}]}]} 05:17:12 INFO - Return code: 0 05:17:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:12 INFO - # TBPL SUCCESS # 05:17:12 INFO - Running post-action listener: _package_coverage_data 05:17:12 INFO - Running post-action listener: _resource_record_post_action 05:17:12 INFO - [mozharness: 2017-08-25 12:17:12.225659Z] Finished run-tests step (success) 05:17:12 INFO - Running post-run listener: _resource_record_post_run 05:17:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 77824; Write bytes: 425615360; Read time: 28; Write time: 283144 05:17:12 INFO - TinderboxPrint: CPU usage
13.3% 05:17:12 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 28 05:17:12 INFO - TinderboxPrint: I/O write bytes / time
425,615,360 / 283,144 05:17:12 INFO - TinderboxPrint: CPU idle
8,267.9 (86.7%) 05:17:12 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 05:17:12 INFO - TinderboxPrint: Swap in / out
0 / 0 05:17:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104742912; Read time: 0; Write time: 84868 05:17:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:17:12 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 77824; Write bytes: 320380928; Read time: 28; Write time: 198244 05:17:12 INFO - Running post-run listener: _upload_blobber_files 05:17:12 INFO - Blob upload gear active. 05:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17: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 05:17: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'] 05:17: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 05:17:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:17:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:16 INFO - (blobuploader) - INFO - Done attempting. 05:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:18 INFO - (blobuploader) - INFO - Done attempting. 05:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:19 INFO - (blobuploader) - INFO - Done attempting. 05:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:19 INFO - (blobuploader) - INFO - Done attempting. 05:17:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:19 INFO - Return code: 0 05:17:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a28e4c94bfe36ffc29a75d7193e4a0dc786d87e6f4ec55940da5be3af24061341c471c8b8fe6457b9121a15a349a4987e2a489aae6226aa193fe17b3d56a42b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/600b6eac258338758e235f51243003ca6f1abc2b11bcd4d491a0a01fdb09e41a4d115134608b60db2c1ed617799ac695a6b709c6a9552df43793373529893e44", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d5e4bb925b287a31693b6ead2efd22117888a632485c441441d913e8ce19480a6464019a8b7aa533150c8f45d37e57f8b9265750c9bcd4192811bf605b0e33"} 05:17:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:19 INFO - Contents: 05:17:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a28e4c94bfe36ffc29a75d7193e4a0dc786d87e6f4ec55940da5be3af24061341c471c8b8fe6457b9121a15a349a4987e2a489aae6226aa193fe17b3d56a42b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/600b6eac258338758e235f51243003ca6f1abc2b11bcd4d491a0a01fdb09e41a4d115134608b60db2c1ed617799ac695a6b709c6a9552df43793373529893e44", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d5e4bb925b287a31693b6ead2efd22117888a632485c441441d913e8ce19480a6464019a8b7aa533150c8f45d37e57f8b9265750c9bcd4192811bf605b0e33"} 05:17:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:19 INFO - Copying logs to upload dir... 05:17:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.571997 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-25 05:17:20.069078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:20.073494) ========= 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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 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/6a28e4c94bfe36ffc29a75d7193e4a0dc786d87e6f4ec55940da5be3af24061341c471c8b8fe6457b9121a15a349a4987e2a489aae6226aa193fe17b3d56a42b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/600b6eac258338758e235f51243003ca6f1abc2b11bcd4d491a0a01fdb09e41a4d115134608b60db2c1ed617799ac695a6b709c6a9552df43793373529893e44", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d5e4bb925b287a31693b6ead2efd22117888a632485c441441d913e8ce19480a6464019a8b7aa533150c8f45d37e57f8b9265750c9bcd4192811bf605b0e33"} build_url:https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/aS8yyg60SCGqrPCGhs8emA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a28e4c94bfe36ffc29a75d7193e4a0dc786d87e6f4ec55940da5be3af24061341c471c8b8fe6457b9121a15a349a4987e2a489aae6226aa193fe17b3d56a42b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/600b6eac258338758e235f51243003ca6f1abc2b11bcd4d491a0a01fdb09e41a4d115134608b60db2c1ed617799ac695a6b709c6a9552df43793373529893e44", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ea00f5dfe74abd3fd4dc3ea87af63ea57b19454d9bfecc02ceccfb7aa05756770c9258feaef60d951ee43b3dc8fc77a93e79d9403f75af24113e8b37b01301", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d5e4bb925b287a31693b6ead2efd22117888a632485c441441d913e8ce19480a6464019a8b7aa533150c8f45d37e57f8b9265750c9bcd4192811bf605b0e33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:20.102885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:20.103217) ========= 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=cbe409c6de289db6ac707de3000001d4-1503648246.330408-1042271097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 05:17:20.152942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 05:17:20.156265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 05:17:20.156567) ========= ========= Total master_lag: 0.43 =========